builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-018 starttime: 1460699233.19 results: success (0) buildid: 20160414215439 builduid: 67dc8b8a396a42e3b81df410dcf9f312 revision: 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.190497) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.190928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.191308) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.207709) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.207971) ========= 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-1460698981.188259-1282741405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-14 22:47:13-- 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% 119K=0.1s 2016-04-14 22:47:13 (119 KB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.192577 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.413368) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.413662) ========= 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-1460698981.188259-1282741405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016841 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:13.462428) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 22:47:13.462767) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d --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 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d --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-1460698981.188259-1282741405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-14 22:47:13,549 truncating revision to first 12 chars 2016-04-14 22:47:13,549 Setting DEBUG logging. 2016-04-14 22:47:13,549 attempt 1/10 2016-04-14 22:47:13,549 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7b9fbf34a1d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-14 22:47:14,832 unpacking tar archive at: fx-team-7b9fbf34a1d6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572390 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-14 22:47:15.048384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:15.048691) ========= script_repo_revision: 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:15.049108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:15.049377) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-14 22:47:15.058542) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-14 22:47:15.058838) ========= /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-1460698981.188259-1282741405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:47:15 INFO - MultiFileLogger online at 20160414 22:47:15 in /builds/slave/test 22:47:15 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:47:15 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:47:15 INFO - {'append_to_log': False, 22:47:15 INFO - 'base_work_dir': '/builds/slave/test', 22:47:15 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:47:15 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:47:15 INFO - 'branch': 'Fx-Team-Non-PGO', 22:47:15 INFO - 'buildbot_json_path': 'buildprops.json', 22:47:15 INFO - 'config_files': ('talos/linux_config.py',), 22:47:15 INFO - 'default_actions': ('clobber', 22:47:15 INFO - 'read-buildbot-config', 22:47:15 INFO - 'download-and-extract', 22:47:15 INFO - 'populate-webroot', 22:47:15 INFO - 'create-virtualenv', 22:47:15 INFO - 'install', 22:47:15 INFO - 'run-tests'), 22:47:15 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:47:15 INFO - 'download_minidump_stackwalk': True, 22:47:15 INFO - 'download_symbols': 'ondemand', 22:47:15 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:47:15 INFO - 'tooltool.py': '/tools/tooltool.py', 22:47:15 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:47:15 INFO - '/tools/misc-python/virtualenv.py')}, 22:47:15 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:47:15 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:47:15 INFO - 'installer_path': 'installer.exe', 22:47:15 INFO - 'log_level': 'info', 22:47:15 INFO - 'log_name': 'talos', 22:47:15 INFO - 'log_to_console': True, 22:47:15 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:47:15 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:47:15 INFO - 'opt_config_files': (), 22:47:15 INFO - 'pip_index': False, 22:47:15 INFO - 'sps_profile': False, 22:47:15 INFO - 'sps_profile_interval': 0, 22:47:15 INFO - 'suite': 'dromaeojs', 22:47:15 INFO - 'system_bits': '32', 22:47:15 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:47:15 INFO - 'title': 'talos-linux64-ix-018', 22:47:15 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:47:15 INFO - 'use_talos_json': True, 22:47:15 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:47:15 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:47:15 INFO - 'work_dir': 'build'} 22:47:15 INFO - ##### 22:47:15 INFO - ##### Running clobber step. 22:47:15 INFO - ##### 22:47:15 INFO - Running pre-action listener: _resource_record_pre_action 22:47:15 INFO - Running main action method: clobber 22:47:15 INFO - rmtree: /builds/slave/test/build 22:47:15 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:47:15 INFO - Running post-action listener: _resource_record_post_action 22:47:15 INFO - ##### 22:47:15 INFO - ##### Running read-buildbot-config step. 22:47:15 INFO - ##### 22:47:15 INFO - Running pre-action listener: _resource_record_pre_action 22:47:15 INFO - Running main action method: read_buildbot_config 22:47:15 INFO - Using buildbot properties: 22:47:15 INFO - { 22:47:15 INFO - "project": "", 22:47:15 INFO - "product": "firefox", 22:47:15 INFO - "script_repo_revision": "production", 22:47:15 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 22:47:15 INFO - "repository": "", 22:47:15 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 22:47:15 INFO - "buildid": "20160414215439", 22:47:15 INFO - "pgo_build": "False", 22:47:15 INFO - "basedir": "/builds/slave/test", 22:47:15 INFO - "buildnumber": 2838, 22:47:15 INFO - "slavename": "talos-linux64-ix-018", 22:47:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:47:15 INFO - "platform": "ubuntu64_hw", 22:47:15 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:47:15 INFO - "branch": "fx-team", 22:47:15 INFO - "repo_path": "integration/fx-team", 22:47:15 INFO - "revision": "7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d", 22:47:15 INFO - "stage_platform": "linux64", 22:47:15 INFO - "builduid": "67dc8b8a396a42e3b81df410dcf9f312", 22:47:15 INFO - "slavebuilddir": "test" 22:47:15 INFO - } 22:47:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 22:47:15 INFO - Running post-action listener: _resource_record_post_action 22:47:15 INFO - ##### 22:47:15 INFO - ##### Running download-and-extract step. 22:47:15 INFO - ##### 22:47:15 INFO - Running pre-action listener: _resource_record_pre_action 22:47:15 INFO - Running main action method: download_and_extract 22:47:15 INFO - mkdir: /builds/slave/test/build/tests 22:47:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:15 INFO - https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 22:47:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:47:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:47:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:18 INFO - Downloaded 1361 bytes. 22:47:18 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 22:47:18 INFO - Using the following test package requirements: 22:47:18 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:18 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:47:18 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 22:47:18 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'jsshell-linux-x86_64.zip'], 22:47:18 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:47:18 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 22:47:18 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:47:18 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:47:18 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:47:18 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 22:47:18 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:47:18 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:47:18 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:47:18 INFO - https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:21 INFO - Downloaded 22202881 bytes. 22:47:21 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:47:21 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:47:22 INFO - Return code: 0 22:47:22 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:47:22 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:47:22 INFO - https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:47:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:47:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 22:47:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:24 INFO - Downloaded 22202881 bytes. 22:47:24 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:47:24 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:47:25 INFO - Return code: 0 22:47:25 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:47:25 INFO - https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:47:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 22:47:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:26 INFO - Downloaded 10841076 bytes. 22:47:26 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:47:26 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:47:27 INFO - Return code: 0 22:47:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:27 INFO - https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:47:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:47:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:47:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JLgLNlRHTaSCH9FEvMromQ/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:47:28 INFO - Downloaded 54445687 bytes. 22:47:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:47:28 INFO - mkdir: /builds/slave/test/properties 22:47:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:47:28 INFO - Writing to file /builds/slave/test/properties/build_url 22:47:28 INFO - Contents: 22:47:28 INFO - build_url:https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 22:47:29 INFO - Running post-action listener: _resource_record_post_action 22:47:29 INFO - Running post-action listener: set_extra_try_arguments 22:47:29 INFO - ##### 22:47:29 INFO - ##### Running populate-webroot step. 22:47:29 INFO - ##### 22:47:29 INFO - Running pre-action listener: _resource_record_pre_action 22:47:29 INFO - Running main action method: populate_webroot 22:47:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:47:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:47:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:47:29 INFO - '--tppagecycles', 22:47:29 INFO - '7'], 22:47:29 INFO - 'tests': ['tsvgm']}}, 22:47:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:47:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 22:47:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 22:47:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 22:47:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:47:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['damp', 'tps']}, 22:47:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'tests': ['damp', 'tps']}, 22:47:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['dromaeo_dom']}, 22:47:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:47:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'other-e10s': {'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['a11yr', 22:47:29 INFO - 'ts_paint', 22:47:29 INFO - 'tpaint', 22:47:29 INFO - 'sessionrestore', 22:47:29 INFO - 'sessionrestore_no_auto_restore', 22:47:29 INFO - 'tabpaint']}, 22:47:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['tsvgx', 22:47:29 INFO - 'tsvgr_opacity', 22:47:29 INFO - 'tart', 22:47:29 INFO - 'tscrollx', 22:47:29 INFO - 'cart']}, 22:47:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 22:47:29 INFO - 'tsvgr_opacity', 22:47:29 INFO - 'tart', 22:47:29 INFO - 'tscrollx', 22:47:29 INFO - 'cart']}, 22:47:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'talos_options': ['--disable-e10s'], 22:47:29 INFO - 'tests': ['tp5o']}, 22:47:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'tests': ['tp5o']}, 22:47:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'talos_options': ['--disable-e10s', 22:47:29 INFO - '--xperf_path', 22:47:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:29 INFO - 'tests': ['tp5n']}, 22:47:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:47:29 INFO - 'talos_options': ['--xperf_path', 22:47:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:47:29 INFO - 'tests': ['tp5n']}}, 22:47:29 INFO - 'talos.zip': {'path': '', 22:47:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:47:29 INFO - Running post-action listener: _resource_record_post_action 22:47:29 INFO - ##### 22:47:29 INFO - ##### Running create-virtualenv step. 22:47:29 INFO - ##### 22:47:29 INFO - Running pre-action listener: _resource_record_pre_action 22:47:29 INFO - Running main action method: create_virtualenv 22:47:29 INFO - Creating virtualenv /builds/slave/test/build/venv 22:47:29 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:47:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:47:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:47:29 INFO - Using real prefix '/usr' 22:47:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:47:29 INFO - Installing distribute.............................................................................................................................................................................................done. 22:47:31 INFO - Installing pip.................done. 22:47:31 INFO - Return code: 0 22:47:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:31 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:31 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:47:31 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:47:31 INFO - Using env: {'DISPLAY': ':0', 22:47:31 INFO - 'HOME': '/home/cltbld', 22:47:31 INFO - 'LANG': 'en_US.UTF-8', 22:47:31 INFO - 'LANGUAGE': 'en_US:en', 22:47:31 INFO - 'LOGNAME': 'cltbld', 22:47:31 INFO - 'MAIL': '/var/mail/cltbld', 22:47:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:31 INFO - 'MOZ_NO_REMOTE': '1', 22:47:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:31 INFO - 'NO_EM_RESTART': '1', 22:47:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:31 INFO - 'PWD': '/builds/slave/test', 22:47:31 INFO - 'SHELL': '/bin/bash', 22:47:31 INFO - 'SHLVL': '1', 22:47:31 INFO - 'TERM': 'linux', 22:47:31 INFO - 'TMOUT': '86400', 22:47:31 INFO - 'USER': 'cltbld', 22:47:31 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:31 INFO - '_': '/tools/buildbot/bin/python'} 22:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:32 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:47:32 INFO - Cleaning up... 22:47:32 INFO - Return code: 0 22:47:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:47:32 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:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:32 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:47:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:32 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:32 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:47:32 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:47:32 INFO - Using env: {'DISPLAY': ':0', 22:47:32 INFO - 'HOME': '/home/cltbld', 22:47:32 INFO - 'LANG': 'en_US.UTF-8', 22:47:32 INFO - 'LANGUAGE': 'en_US:en', 22:47:32 INFO - 'LOGNAME': 'cltbld', 22:47:32 INFO - 'MAIL': '/var/mail/cltbld', 22:47:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:32 INFO - 'MOZ_NO_REMOTE': '1', 22:47:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:32 INFO - 'NO_EM_RESTART': '1', 22:47:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:32 INFO - 'PWD': '/builds/slave/test', 22:47:32 INFO - 'SHELL': '/bin/bash', 22:47:32 INFO - 'SHLVL': '1', 22:47:32 INFO - 'TERM': 'linux', 22:47:32 INFO - 'TMOUT': '86400', 22:47:32 INFO - 'USER': 'cltbld', 22:47:32 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:32 INFO - '_': '/tools/buildbot/bin/python'} 22:47:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:32 INFO - Downloading/unpacking psutil>=0.7.1 22:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:47:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:34 INFO - Installing collected packages: psutil 22:47:34 INFO - Running setup.py install for psutil 22:47:34 INFO - building 'psutil._psutil_linux' extension 22:47:34 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:47:34 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:47:34 INFO - building 'psutil._psutil_posix' extension 22:47:34 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:47:34 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:47:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:47:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:47:34 INFO - Successfully installed psutil 22:47:34 INFO - Cleaning up... 22:47:34 INFO - Return code: 0 22:47:34 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:47:34 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:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:34 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:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:34 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:34 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:47:34 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:47:34 INFO - Using env: {'DISPLAY': ':0', 22:47:34 INFO - 'HOME': '/home/cltbld', 22:47:34 INFO - 'LANG': 'en_US.UTF-8', 22:47:34 INFO - 'LANGUAGE': 'en_US:en', 22:47:34 INFO - 'LOGNAME': 'cltbld', 22:47:34 INFO - 'MAIL': '/var/mail/cltbld', 22:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:34 INFO - 'MOZ_NO_REMOTE': '1', 22:47:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:34 INFO - 'NO_EM_RESTART': '1', 22:47:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:34 INFO - 'PWD': '/builds/slave/test', 22:47:34 INFO - 'SHELL': '/bin/bash', 22:47:34 INFO - 'SHLVL': '1', 22:47:34 INFO - 'TERM': 'linux', 22:47:34 INFO - 'TMOUT': '86400', 22:47:34 INFO - 'USER': 'cltbld', 22:47:34 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:34 INFO - '_': '/tools/buildbot/bin/python'} 22:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:47:35 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:47:35 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:47:35 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:47:35 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:47:35 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:47:35 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:47:36 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:47:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:47:36 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:47:36 INFO - Installing collected packages: mozsystemmonitor 22:47:36 INFO - Running setup.py install for mozsystemmonitor 22:47:37 INFO - Successfully installed mozsystemmonitor 22:47:37 INFO - Cleaning up... 22:47:37 INFO - Return code: 0 22:47:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:37 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:37 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:47:37 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:47:37 INFO - Using env: {'DISPLAY': ':0', 22:47:37 INFO - 'HOME': '/home/cltbld', 22:47:37 INFO - 'LANG': 'en_US.UTF-8', 22:47:37 INFO - 'LANGUAGE': 'en_US:en', 22:47:37 INFO - 'LOGNAME': 'cltbld', 22:47:37 INFO - 'MAIL': '/var/mail/cltbld', 22:47:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:37 INFO - 'MOZ_NO_REMOTE': '1', 22:47:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:37 INFO - 'NO_EM_RESTART': '1', 22:47:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:37 INFO - 'PWD': '/builds/slave/test', 22:47:37 INFO - 'SHELL': '/bin/bash', 22:47:37 INFO - 'SHLVL': '1', 22:47:37 INFO - 'TERM': 'linux', 22:47:37 INFO - 'TMOUT': '86400', 22:47:37 INFO - 'USER': 'cltbld', 22:47:37 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:37 INFO - '_': '/tools/buildbot/bin/python'} 22:47:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:37 INFO - Downloading/unpacking blobuploader==1.2.4 22:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:37 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:47:39 INFO - Downloading blobuploader-1.2.4.tar.gz 22:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:47:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:47:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:39 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:47:40 INFO - Downloading docopt-0.6.1.tar.gz 22:47:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:47:40 INFO - Installing collected packages: blobuploader, requests, docopt 22:47:40 INFO - Running setup.py install for blobuploader 22:47:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:47:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:47:40 INFO - Running setup.py install for requests 22:47:40 INFO - Running setup.py install for docopt 22:47:40 INFO - Successfully installed blobuploader requests docopt 22:47:40 INFO - Cleaning up... 22:47:40 INFO - Return code: 0 22:47:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47: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:47:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:40 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:40 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:47:40 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:47:40 INFO - Using env: {'DISPLAY': ':0', 22:47:40 INFO - 'HOME': '/home/cltbld', 22:47:40 INFO - 'LANG': 'en_US.UTF-8', 22:47:40 INFO - 'LANGUAGE': 'en_US:en', 22:47:40 INFO - 'LOGNAME': 'cltbld', 22:47:40 INFO - 'MAIL': '/var/mail/cltbld', 22:47:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:40 INFO - 'MOZ_NO_REMOTE': '1', 22:47:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:40 INFO - 'NO_EM_RESTART': '1', 22:47:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:40 INFO - 'PWD': '/builds/slave/test', 22:47:40 INFO - 'SHELL': '/bin/bash', 22:47:40 INFO - 'SHLVL': '1', 22:47:40 INFO - 'TERM': 'linux', 22:47:40 INFO - 'TMOUT': '86400', 22:47:40 INFO - 'USER': 'cltbld', 22:47:40 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:40 INFO - '_': '/tools/buildbot/bin/python'} 22:47:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:47:40 INFO - Running setup.py (path:/tmp/pip-elymRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:47:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:47:40 INFO - Running setup.py (path:/tmp/pip-T0UQlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:47:41 INFO - Running setup.py (path:/tmp/pip-Gsunbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:47:41 INFO - Running setup.py (path:/tmp/pip-FbvZEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:47:41 INFO - Running setup.py (path:/tmp/pip-S6GxRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:47:41 INFO - Running setup.py (path:/tmp/pip-3jyjJ8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:47:41 INFO - Running setup.py (path:/tmp/pip-Q1r7Ri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:47:41 INFO - Running setup.py (path:/tmp/pip-wMiBlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:47:41 INFO - Running setup.py (path:/tmp/pip-AdM0Rc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:47:41 INFO - Running setup.py (path:/tmp/pip-dPzmxW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:47:41 INFO - Running setup.py (path:/tmp/pip-WxJ8k7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:47:41 INFO - Running setup.py (path:/tmp/pip-erHv9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:47:41 INFO - Running setup.py (path:/tmp/pip-ctYwv_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:47:41 INFO - Running setup.py (path:/tmp/pip-PxPcOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:47:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:41 INFO - Running setup.py (path:/tmp/pip-pR7ef4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:47:42 INFO - Running setup.py (path:/tmp/pip-eyR31a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:47:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:47:42 INFO - Running setup.py (path:/tmp/pip-WFwFVS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:47:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:47:42 INFO - Running setup.py install for manifestparser 22:47:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Running setup.py install for mozcrash 22:47:42 INFO - Running setup.py install for mozdebug 22:47:42 INFO - Running setup.py install for mozdevice 22:47:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Running setup.py install for mozfile 22:47:42 INFO - Running setup.py install for mozhttpd 22:47:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Running setup.py install for mozinfo 22:47:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Running setup.py install for mozInstall 22:47:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:47:42 INFO - Running setup.py install for mozleak 22:47:43 INFO - Running setup.py install for mozlog 22:47:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Running setup.py install for moznetwork 22:47:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Running setup.py install for mozprocess 22:47:43 INFO - Running setup.py install for mozprofile 22:47:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Running setup.py install for mozrunner 22:47:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Running setup.py install for mozscreenshot 22:47:43 INFO - Running setup.py install for moztest 22:47:43 INFO - Running setup.py install for mozversion 22:47:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:47:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:47:43 INFO - Cleaning up... 22:47:43 INFO - Return code: 0 22:47:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:43 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:47:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:43 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:47:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:43 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:43 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:47:43 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:47:43 INFO - Using env: {'DISPLAY': ':0', 22:47:43 INFO - 'HOME': '/home/cltbld', 22:47:43 INFO - 'LANG': 'en_US.UTF-8', 22:47:43 INFO - 'LANGUAGE': 'en_US:en', 22:47:43 INFO - 'LOGNAME': 'cltbld', 22:47:43 INFO - 'MAIL': '/var/mail/cltbld', 22:47:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:43 INFO - 'MOZ_NO_REMOTE': '1', 22:47:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:43 INFO - 'NO_EM_RESTART': '1', 22:47:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:43 INFO - 'PWD': '/builds/slave/test', 22:47:43 INFO - 'SHELL': '/bin/bash', 22:47:43 INFO - 'SHLVL': '1', 22:47:43 INFO - 'TERM': 'linux', 22:47:43 INFO - 'TMOUT': '86400', 22:47:43 INFO - 'USER': 'cltbld', 22:47:43 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:43 INFO - '_': '/tools/buildbot/bin/python'} 22:47:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:47:44 INFO - Running setup.py (path:/tmp/pip-6XP5sB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:47:44 INFO - Running setup.py (path:/tmp/pip-NLTpbU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:47:44 INFO - Running setup.py (path:/tmp/pip-wGKMkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:47:44 INFO - Running setup.py (path:/tmp/pip-VOqJFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:47:44 INFO - Running setup.py (path:/tmp/pip-ntlvdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:47:44 INFO - Running setup.py (path:/tmp/pip-x6QbE8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:47:44 INFO - Running setup.py (path:/tmp/pip-o_MtlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:47:44 INFO - Running setup.py (path:/tmp/pip-NnT1Jk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:47:44 INFO - Running setup.py (path:/tmp/pip-hWeM1S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:47:44 INFO - Running setup.py (path:/tmp/pip-v5CH6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:47:44 INFO - Running setup.py (path:/tmp/pip-drWd5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:47:44 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:47:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:47:44 INFO - Running setup.py (path:/tmp/pip-4kov6k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:47:45 INFO - Running setup.py (path:/tmp/pip-s7pi04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:47:45 INFO - Running setup.py (path:/tmp/pip-Rl908t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:45 INFO - Running setup.py (path:/tmp/pip-Kzgg1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:47:45 INFO - Running setup.py (path:/tmp/pip-e542V2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:47:45 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:47:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:47:45 INFO - Running setup.py (path:/tmp/pip-PZ86cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 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:47:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:47:47 INFO - Downloading blessings-1.6.tar.gz 22:47:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:47:47 INFO - Installing collected packages: blessings 22:47:47 INFO - Running setup.py install for blessings 22:47:47 INFO - Successfully installed blessings 22:47:47 INFO - Cleaning up... 22:47:47 INFO - Return code: 0 22:47:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:47:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:47:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:47:47 INFO - Reading from file tmpfile_stdout 22:47:47 INFO - Current package versions: 22:47:47 INFO - argparse == 1.2.1 22:47:47 INFO - blessings == 1.6 22:47:47 INFO - blobuploader == 1.2.4 22:47:47 INFO - docopt == 0.6.1 22:47:47 INFO - manifestparser == 1.1 22:47:47 INFO - mozInstall == 1.12 22:47:47 INFO - mozcrash == 0.17 22:47:47 INFO - mozdebug == 0.1 22:47:47 INFO - mozdevice == 0.48 22:47:47 INFO - mozfile == 1.2 22:47:47 INFO - mozhttpd == 0.7 22:47:47 INFO - mozinfo == 0.9 22:47:47 INFO - mozleak == 0.1 22:47:47 INFO - mozlog == 3.1 22:47:47 INFO - moznetwork == 0.27 22:47:47 INFO - mozprocess == 0.22 22:47:47 INFO - mozprofile == 0.28 22:47:47 INFO - mozrunner == 6.11 22:47:47 INFO - mozscreenshot == 0.1 22:47:47 INFO - mozsystemmonitor == 0.0 22:47:47 INFO - moztest == 0.7 22:47:47 INFO - mozversion == 1.4 22:47:47 INFO - psutil == 3.1.1 22:47:47 INFO - requests == 1.2.3 22:47:47 INFO - wsgiref == 0.1.2 22:47:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:47 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:47 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:47:47 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:47:47 INFO - Using env: {'DISPLAY': ':0', 22:47:47 INFO - 'HOME': '/home/cltbld', 22:47:47 INFO - 'LANG': 'en_US.UTF-8', 22:47:47 INFO - 'LANGUAGE': 'en_US:en', 22:47:47 INFO - 'LOGNAME': 'cltbld', 22:47:47 INFO - 'MAIL': '/var/mail/cltbld', 22:47:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:47 INFO - 'MOZ_NO_REMOTE': '1', 22:47:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:47 INFO - 'NO_EM_RESTART': '1', 22:47:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:47 INFO - 'PWD': '/builds/slave/test', 22:47:47 INFO - 'SHELL': '/bin/bash', 22:47:47 INFO - 'SHLVL': '1', 22:47:47 INFO - 'TERM': 'linux', 22:47:47 INFO - 'TMOUT': '86400', 22:47:47 INFO - 'USER': 'cltbld', 22:47:47 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:47 INFO - '_': '/tools/buildbot/bin/python'} 22:47:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 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:47:47 INFO - Cleaning up... 22:47:47 INFO - Return code: 0 22:47:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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:47:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47: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', 'jsonschema'] in /builds/slave/test/build 22:47: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 jsonschema 22:47:48 INFO - Using env: {'DISPLAY': ':0', 22:47:48 INFO - 'HOME': '/home/cltbld', 22:47:48 INFO - 'LANG': 'en_US.UTF-8', 22:47:48 INFO - 'LANGUAGE': 'en_US:en', 22:47:48 INFO - 'LOGNAME': 'cltbld', 22:47:48 INFO - 'MAIL': '/var/mail/cltbld', 22:47:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:48 INFO - 'MOZ_NO_REMOTE': '1', 22:47:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:48 INFO - 'NO_EM_RESTART': '1', 22:47:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:48 INFO - 'PWD': '/builds/slave/test', 22:47:48 INFO - 'SHELL': '/bin/bash', 22:47:48 INFO - 'SHLVL': '1', 22:47:48 INFO - 'TERM': 'linux', 22:47:48 INFO - 'TMOUT': '86400', 22:47:48 INFO - 'USER': 'cltbld', 22:47:48 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:48 INFO - '_': '/tools/buildbot/bin/python'} 22:47:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:48 INFO - Downloading/unpacking jsonschema 22:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:48 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:47:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:47:50 INFO - Downloading/unpacking functools32 (from jsonschema) 22:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 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:47:50 INFO - Downloading functools32-3.2.3-2.tar.gz 22:47:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:47:50 INFO - warning: no files found matching '*.txt' 22:47:50 INFO - no previously-included directories found matching 'build' 22:47:50 INFO - no previously-included directories found matching 'dist' 22:47:50 INFO - no previously-included directories found matching '.git*' 22:47:50 INFO - Installing collected packages: jsonschema, functools32 22:47:50 INFO - Running setup.py install for functools32 22:47:50 INFO - warning: no files found matching '*.txt' 22:47:50 INFO - no previously-included directories found matching 'build' 22:47:50 INFO - no previously-included directories found matching 'dist' 22:47:50 INFO - no previously-included directories found matching '.git*' 22:47:50 INFO - Successfully installed jsonschema functools32 22:47:50 INFO - Cleaning up... 22:47:50 INFO - Return code: 0 22:47:50 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 22:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:47:50 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 0x7f386f082f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26cd8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27985a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, '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-1460698981.188259-1282741405', '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:47:50 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:47:50 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:47:50 INFO - Using env: {'DISPLAY': ':0', 22:47:50 INFO - 'HOME': '/home/cltbld', 22:47:50 INFO - 'LANG': 'en_US.UTF-8', 22:47:50 INFO - 'LANGUAGE': 'en_US:en', 22:47:50 INFO - 'LOGNAME': 'cltbld', 22:47:50 INFO - 'MAIL': '/var/mail/cltbld', 22:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:47:50 INFO - 'MOZ_NO_REMOTE': '1', 22:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:47:50 INFO - 'NO_EM_RESTART': '1', 22:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:47:50 INFO - 'PWD': '/builds/slave/test', 22:47:50 INFO - 'SHELL': '/bin/bash', 22:47:50 INFO - 'SHLVL': '1', 22:47:50 INFO - 'TERM': 'linux', 22:47:50 INFO - 'TMOUT': '86400', 22:47:50 INFO - 'USER': 'cltbld', 22:47:50 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:47:50 INFO - '_': '/tools/buildbot/bin/python'} 22:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:47:51 INFO - Downloading/unpacking flake8 22:47:51 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:47:51 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:47:51 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:47:51 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:47:51 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:47:51 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:47:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 22:47:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 22:47: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:47: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:47: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:47: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:47: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:47: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:47:53 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 22:47:53 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 22:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 22:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 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:47:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 22:47:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:47:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:47:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:47:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:47:53 INFO - no previously-included directories found matching 'docs/_build' 22:47:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 22:47:53 INFO - Running setup.py install for pep8 22:47:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 22:47:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 22:47:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 22:47:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 22:47:53 INFO - no previously-included directories found matching 'docs/_build' 22:47:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 22:47:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 22:47:53 INFO - Cleaning up... 22:47:53 INFO - Return code: 0 22:47:53 INFO - Running post-action listener: _resource_record_post_action 22:47:53 INFO - Running post-action listener: _start_resource_monitoring 22:47:53 INFO - Starting resource monitoring. 22:47:53 INFO - ##### 22:47:53 INFO - ##### Running install step. 22:47:53 INFO - ##### 22:47:53 INFO - Running pre-action listener: _resource_record_pre_action 22:47:53 INFO - Running main action method: install 22:47:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:47:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:47:54 INFO - Reading from file tmpfile_stdout 22:47:54 INFO - Detecting whether we're running mozinstall >=1.0... 22:47:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:47:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:47:54 INFO - Reading from file tmpfile_stdout 22:47:54 INFO - Output received: 22:47:54 INFO - Usage: mozinstall [options] installer 22:47:54 INFO - Options: 22:47:54 INFO - -h, --help show this help message and exit 22:47:54 INFO - -d DEST, --destination=DEST 22:47:54 INFO - Directory to install application into. [default: 22:47:54 INFO - "/builds/slave/test"] 22:47:54 INFO - --app=APP Application being installed. [default: firefox] 22:47:54 INFO - mkdir: /builds/slave/test/build/application 22:47:54 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:47:54 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:48:09 INFO - Reading from file tmpfile_stdout 22:48:09 INFO - Output received: 22:48:09 INFO - /builds/slave/test/build/application/firefox/firefox 22:48:09 INFO - Running post-action listener: _resource_record_post_action 22:48:09 INFO - ##### 22:48:09 INFO - ##### Running run-tests step. 22:48:09 INFO - ##### 22:48:09 INFO - Running pre-action listener: _resource_record_pre_action 22:48:09 INFO - Running main action method: run_tests 22:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:48:09 INFO - Python 2.7.3 22:48:09 INFO - Return code: 0 22:48:09 INFO - grabbing minidump binary from tooltool 22:48:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:48:09 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 0x2827410>, '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 0x2828310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x28287a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:48:09 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:48:09 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:48:09 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:48:09 INFO - Return code: 0 22:48:09 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:48:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:48:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:48:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:48:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:48:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 22:48:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 22:48:10 INFO - Return code: 0 22:48:10 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/JLgLNlRHTaSCH9FEvMromQ/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:48:10 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/JLgLNlRHTaSCH9FEvMromQ/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:48:10 INFO - Using env: {'DISPLAY': ':0', 22:48:10 INFO - 'HOME': '/home/cltbld', 22:48:10 INFO - 'LANG': 'en_US.UTF-8', 22:48:10 INFO - 'LANGUAGE': 'en_US:en', 22:48:10 INFO - 'LOGNAME': 'cltbld', 22:48:10 INFO - 'MAIL': '/var/mail/cltbld', 22:48:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:48:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:48:10 INFO - 'MOZ_NO_REMOTE': '1', 22:48:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:48:10 INFO - 'NO_EM_RESTART': '1', 22:48:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:48:10 INFO - 'PWD': '/builds/slave/test', 22:48:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:48:10 INFO - 'SHELL': '/bin/bash', 22:48:10 INFO - 'SHLVL': '1', 22:48:10 INFO - 'TERM': 'linux', 22:48:10 INFO - 'TMOUT': '86400', 22:48:10 INFO - 'USER': 'cltbld', 22:48:10 INFO - 'XDG_SESSION_COOKIE': '62c568580acbfdaac3eec7be000001dc-1460698981.188259-1282741405', 22:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:48:10 INFO - '_': '/tools/buildbot/bin/python'} 22:48:10 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/JLgLNlRHTaSCH9FEvMromQ/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:48:11 INFO - mozversion application_buildid: 20160414215439 22:48:11 INFO - mozversion application_changeset: 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d 22:48:11 INFO - mozversion application_display_name: Nightly 22:48:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:48:11 INFO - mozversion application_name: Firefox 22:48:11 INFO - mozversion application_remotingname: firefox 22:48:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 22:48:11 INFO - mozversion application_vendor: Mozilla 22:48:11 INFO - mozversion application_version: 48.0a1 22:48:11 INFO - mozversion platform_buildid: 20160414215439 22:48:11 INFO - mozversion platform_changeset: 7b9fbf34a1d6c4a4a54486b64f2be9c8b304401d 22:48:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 22:48:11 INFO - mozversion platform_version: 48.0a1 22:48:11 INFO - using testdate: 1460699291 22:48:11 INFO - actual date: 1460699291 22:48:11 INFO - starting webserver on 'localhost:59306' 22:48:11 INFO - SUITE-START | Running 2 tests 22:48:11 INFO - TEST-START | dromaeo_css 22:48:11 INFO - operating with platform_type : linux_ 22:48:11 INFO - Initialising browser for dromaeo_css test... 22:48:11 INFO - TEST-INFO | started process 4807 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQFC5g/profile http://localhost:59306/getInfo.html) 22:48:15 INFO - PROCESS | 4807 | __metrics Screen width/height:1600/1200 22:48:15 INFO - PROCESS | 4807 | colorDepth:24 22:48:15 INFO - PROCESS | 4807 | Browser inner width/height: 1024/697 22:48:15 INFO - PROCESS | 4807 | __metrics 22:48:16 ERROR - PROCESS | 4807 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:48:17 INFO - TEST-INFO | 4807: exit 0 22:48:17 INFO - Browser initialized. 22:48:17 INFO - Running cycle 1/1 for dromaeo_css test... 22:48:17 INFO - TEST-INFO | started process 4887 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbQFC5g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:48:29 INFO - PROCESS | 4887 | RSS: Main: 154296320 22:48:29 INFO - PROCESS | 4887 | 22:49:20 INFO - PROCESS | 4887 | 1460699360291 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:51:32 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59306/tests/dromaeo/cssquery-ext.html) 22:51:33 INFO - PROCESS | 4887 | RSS: Main: 274452480 22:51:33 INFO - PROCESS | 4887 | 22:54:36 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-ext.html (next: http://localhost:59306/tests/dromaeo/cssquery-jquery.html) 22:54:36 INFO - PROCESS | 4887 | RSS: Main: 237854720 22:54:36 INFO - PROCESS | 4887 | 22:57:39 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59306/tests/dromaeo/cssquery-mootools.html) 22:57:39 INFO - PROCESS | 4887 | RSS: Main: 231096320 22:57:39 INFO - PROCESS | 4887 | 23:00:41 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59306/tests/dromaeo/cssquery-prototype.html) 23:00:42 INFO - PROCESS | 4887 | RSS: Main: 228786176 23:00:42 INFO - PROCESS | 4887 | 23:03:45 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59306/tests/dromaeo/cssquery-yui.html) 23:03:45 INFO - PROCESS | 4887 | RSS: Main: 220745728 23:03:45 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | Cycle 1(1): loaded http://localhost:59306/tests/dromaeo/cssquery-yui.html (next: http://localhost:59306/tests/dromaeo/cssquery-dojo.html) 23:06:48 INFO - PROCESS | 4887 | RSS: Main: 273846272 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | __start_tp_report 23:06:48 INFO - PROCESS | 4887 | _x_x_mozilla_page_load 23:06:48 INFO - PROCESS | 4887 | _x_x_mozilla_page_load_details 23:06:48 INFO - PROCESS | 4887 | |i|pagename|runs| 23:06:48 INFO - PROCESS | 4887 | |0;dojo.html;2630.9736902630975;2690.260178450927;2694.205209463208;2698.5142674318627;2721.564549672052;4600.194965880974;4635.675502714807;4649.209634362158;4665.813367465297;4688.648351373652;4612.400387949562;4630.143423466652;4702.929456058153;4713.811447542094;4721.362616046833;4304.5695430456935;4335.739855608674;4338.913221735579;4389.253826849444;4411.514733379326;4344.478662560481;4354.412154359153;4387.473503179623;4413.668974826885;4419.447569053868;4256.531781504032;4312.805923733439;4340.500842403132;4382.583654552813;4388.780560971939;4232.894177645583;4243.6605071594195;4255.5744425557505;4265.104328091104;4265.44549208604;4208.0952595191875;4208.410822484854;4213.91572168558;4216.2832318505925;4221.598948099926;4492.034212644297;4497.7526236057;4508.278675411918;4527.569880861313;4597.126545956257;4983;5003.424606170264;5016.147254966664;5019.64862459628;5019.974900125512;4998.350214472095;5009.499050094998;5012.573931215815;5050.065737838511;5066.46802085783;4556.134334476439;4660.930086048712;4661.277501987163;4726.125666751662;4737.147313483537;5034.320366750515;5076.949230507647;5078.314427552307;5079.3650793650795;5087.084324821568;4883.975580122148;4889.071076495455;4889.951100489021;4891.437484689235;4935.7532123393685;4877.731724755102;4999.950000500021;5049.747512624354;5077;5098.745062746848;4951.653384263139;4969.90060198794;4975.328330675313;4978.701277923336;5025.773840177128;4851.393575803025;4959.752012399365;4968.552830245295;4971.45314015458;5019.623528235397;4220.556841531657;4222.619964203236;4229;4283.785810709452;4298.398224248608;3681.37416639172;3703.2408356286896;3708.851645934132;3743.494628225155;3747.775133491999;4361.869143925687;4362.8036738346855;4366.061296821199;4369.235383807821;4406.27296496081;4861.756912154449;4999.02519008797;5059.519345662156;5071.594272458195;5097.057044446789;4346.8043938022865;4350.499692535335;4364.192624364503;4365.301551751768;4407.206702793464;4435.090806384684;4528.388667529907;4529.818807247673;4531.501534831166;4573.245414506636;4742.976285118552;4786.641001924939;4790.952090479051;4821.421429428491;4831.396075490564;4987.177115775857;4988.226824842155;5026.648134630541;5029.572486338702;5084.923726144185;4629.93055104167;4741.881452963704;4753.5008824072975;4761.6904901181315;4800.375951126471;4949.802007919643;4969.279454479152;4971.279164521196;4975.0547395994645;5024.371953505812;5003.199488081889;5038.39539255277;5039.445660977216;5041.193409054534;5100.5409513143995;4741.051789642016;4828.058528586892;4890.682105663121;4912.533309335608;4944.975275123746;4863.90272194547;4888.2178851383605;4895.167821470287;4917.803287868445;4934.185859333314;4790.520947905321;4809.2064809306075;4817.470078291455;4835.274708793709;4884.096442158212;4720.598749106227;4821.927671085006;4824.228123500223;4894.388201474816;4919.926201107058;4686.718796872198;4780.330753694555;4786.664933454764;4790.976045119752;4809.855704328876 23:06:48 INFO - PROCESS | 4887 | |1;ext.html;568.4031766645022;604.9021026836294;605.5518916002158;614.9576467886933;631.5484428633526;26084.73915260847;33853.1536711582;34992.475112873326;35017.474737878954;35031.82484087579;39480;40167.19665606686;40299.59700402995;40308;40396;7761.534307941542;7935.404844636647;7946.404019698517;7956.443048986574;7956.880646790303;7657.11943126542;7801.882971755428;7812.453128281023;7816.335611473031;7818.804529886742;7834.177411371809;7843.607819609026;7856.7642970710685;7894.2105789421175;7899.447038707292;7777.494462859896;7818.843623127563;7830.021247344082;7832.216778322179;7835.843283134305;7774.572398518079;7891.842163156704;7894.2105789421175;7897.960510197469;7905.486143400661;34568.48147277793;34872.12819679503;34899.302013959576;34915.12712182216;34991.1252218694;2907.636545431821;3038.5745995560637;3184.2357834119875;3259;3369.444041733111;28131.29671758202;28778.712212877814;28864;28975.42049159026;29463.852680736458;3417.4532074868152;3446.2418267981;3492.947605785915;3509.5262139611336;3524.2599054198395;173500;173644;174062;174275;174811;33587.328253435284;49779.25331120036;51566.74216628893;51600.48399516032;51622;33706.831465842515;33958.15104622404;33988;34004.48993265103;34018.31963360719;13189.538366157138;13340.266285354204;13348.332583370793;13355.46578136883;13355.53255636048;9903.356281841658;9917.206623470249;9922.851157232648;9989;10006.449645269435;8116.472429292077;8127.3904457165945;8152.796180095545;8202.671893124327;8204.097549269576;3152.2417884351194;3200.8399580020905;3205.8557364918634;3252.219467327824;3267.607887053521;934.6962237272913;981.5337714585514;987.6987518806833;1021.1320377679062;1074.6453670288786;27862.442751144863;27900.72099278981;28361;28437.715622843505;28522.71477285242;1009.4548943570389;1027.5974830302641;1040.675043236851;1082.3668154129923;1117.7987962166726;14731;14988.625284367978;15052.441085015573;15239.743054312537;15376.53870383868;335595;339146;341644;341843;342122;47434;48185.75907120442;48251;48316.27525587119;48409;1043.4052590023614;1141.4635121492886;1162.035510526261;1224.0697070226693;1260.4727521319696;25516.744832551438;27538;27638.447231054863;27866.58200126959;27980.86009569939;39001.804990974866;39337.213255734154;39349.409758853064;39531.61639342609;39588;182319;183874;184400;184528;185120;24888.751112488644;33879.661203388634;37533.62466375301;37572.43641345327;38949.8052509747;37361.62638373581;37683.81158094192;37794;37871.43192852165;38275;34196.65803341935;34264.82867585746;34340.656593434745;34458.310833782685;34976.30047399089;34211.31577368389;34577.48133778045;34606.65393346135;34710.30579388449;34856.82571587126;34020.31959360749;34177.65822341844;34411.82794086014;36756.632433675324;38127.618723812404;29492.410151797274;31099;31434.842825785723;31506;31659.84170079135;24220.254521630257;24542.75457245476;24615.38461538476;24927.875360623082;25013.624795627715 23:06:48 INFO - PROCESS | 4887 | |2;jquery.html;368.3590552438756;369.44767572479145;392.70547089682736;395.33583579586286;397.24126917587415;15934.760978585316;17777.37779177729;17853.821461785377;17969.550761230992;18003.729944050818;16611;16880.577985550368;17054.403095891645;17437.21532531036;17490.82509174908;5085.211792172219;5211.088059589576;5236.973815130938;5255.710935898524;5258.2638430619745;3726.7577607455564;3995.8601448949294;5464.352260468761;5917.9408205918035;5930.762769489215;5619.044762390383;5826.6212696174825;5831.096180092092;5833.591648584579;5855.648661080328;5782.479576838084;5796.942030579704;5876.764929402819;5892.499137573312;5892.880352732967;5116.846494605168;5276.050310944029;5276.076686579833;5278.181881808326;5285.2600635911;20203.898980505004;20327.085281162235;20688.379348619565;20828.58342833135;20956.16175352984;1770.97343539847;1956.2077358669762;2004.5690176611952;2013.496625843539;2093.7801530839347;9253.889533255984;9457.527123643791;9571.664991725325;12579;12686.746265074647;1712.1695977450927;1717.9484615461556;1730.7403889416562;1768.522498925283;1804.2422182683304;51357.48642513564;54734.17898731522;60641.6967915162;66359.66820165869;69323.3067669327;9678;9803.607855685692;9885.456299903575;9936.304458687822;10000.899990999997;13334.666633334244;13454.663633409244;13491.595252142255;13510.86489135096;13561;7337.88993165103;7394.630268486661;7481.289277518627;7542.962285188539;7544.358729507943;7050.788476345718;7183.281671832775;7199.2080871104135;7282.271772822675;7332.156801967842;4057.5739547347694;4255.29787585045;4399.23013472641;4412.713173643703;4512.81948722054;1750.8336708012719;1846.3999200259968;1880.45802441999;1904.9047547622563;1954.3159894036974;816.4774544291658;874.8206617643368;880.2825697056878;886.1625763653286;895.4671970177734;16155.353785848434;16901.830981690273;17065.658686826195;17336.30654773795;17384.130793460277;871.4030888841164;889.6886089868494;904.4663648447447;933.3606479561522;953.5994882149514;9117.36178467501;9205.355625106313;9575.281853860988;9695.351790195684;9840.458774767456;378376;382731;384435;385258;389561;76632.23367766362;79993.60003199946;80114.19885801183;80392.59803700945;80889.89163368035;843.1913545444986;905.298393744853;931.7903471718809;948.9383190092622;963.4171326347599;14639.121652700445;14759.409623615365;14847.480338188112;14874.77687834705;15285.159316237714;31803.20491987719;32329.676703232668;33496.1625959353;33588.328233435685;33619.15952101217;47105;47190.52809471861;47204.055918880746;47358.05283894234;47998.5200148008;7709.922900771145;7779.844403112019;7883.605819709106;7895.84208315819;7912.960435197787;10409.9479502602;10793.892061079603;10796.082333001468;10879.401632910265;10946.17903657213;10084.747881303027;10184.083432491112;10333.793324133325;10348.741281468023;10615.31000484966;9241.168294853496;9593.42439453635;10005.499725013866;10184.134348580157;10244.692659220234;10422.843657344994;10467.214958878267;10568.365898046142;10674.199435042558;10941.781164376827;7598.582077985764;7705.460617756703;7747;7765.53406795594;7793.1427542969095;9411.717648470283;9713.562889670124;10196.082352588302;10267.383956962607;10298.279120461795 23:06:48 INFO - PROCESS | 4887 | |3;mootools.html;1309.1425116548653;1413.6041908265686;1469.1552357394498;1559.2224863655435;1767.0811178187334;6856;7601.239876012396;7871.252231038042;7876.606169691507;7894.92105078949;7544.622768861563;7711.961440192806;7758.262965018328;7762.4178186635945;7774.2614451627005;1886.443499167742;2137;2186.0709198590575;2211.159759291467;2219.7669244729314;2260.536589999046;2278.293728944024;2278.384836094262;2281.669157972093;2288.794008539231;2182.5416662500893;2230.5984922713906;2231.141010710872;2233.597952368573;2234.575430668176;1860.6650802855481;2172.750133734617;2261.570301642683;2264.784845439681;2268.206127855254;2192.901319440629;2198.395441253668;2214.092222188895;2217.6562632791943;2244.6745221942892;7704.46068775186;7775.688972441096;7778.611069446505;7791.22087791222;7796;4523.796429160696;4719.669623126382;4726.409198850144;4737.50256223095;4759.048190361941;2997.640283166034;3062.2803641144314;3083.275430273884;3170.5402716605963;3200.9519857202163;1033.9431331276776;1056.6513050693252;1064.2284343850724;1066.1790421375574;1084.7559299157706;10344.63793767222;10610.787784244349;10647.14822814173;10674.306170098997;10678.092362149227;4223.493180818322;4294.248506511348;4382.890427739332;4412.227860124465;4420.226460369422;9247.167754902091;9255.861162082574;9274.582643781046;9282.582283797245;9285.117913798178;4183.477065366829;4690.859274221779;4697.248440249612;4698.624110071186;4714.834980775657;4120.546739858613;4158.438610787565;4214.262504061777;4221.092465120014;4221.535631080578;3695.6304369562827;3741.5136032315627;3807.3717836556657;3838.673712734393;3881.514810648669;1221.2123180548497;1227.742174143422;1243.570968016033;1248.4007676315239;1258.4148371007343;785.5051317669946;850.6639877248452;894.9931327256836;895.1719659315238;909.60432211988;5474.452554744494;5654.00591698294;5675.3757086720425;5774.307083150049;5842.444967728059;933.9719808405758;937.7915010151132;965.2133511188359;969.9369540979814;1006.4414250091123;3700.648438398348;3861.517310336208;3867.7872717000837;3880.2821478026653;3971.0866500705;9157.130072643089;9367.391119577342;9411.294152938557;9458.196053335543;9541.570629321559;9346.766330841783;9394.812103757886;9396.859047114298;9404.200642945427;9450.810983780424;7131.821704457327;7236.819079522948;7258.927410725931;7291.125064992235;7333.1200255969625;5439.102548079681;5535;5575.8884822304135;5609.663420194638;5746.42535746422;8700.303975681803;8796.428232164888;8838;8953.776155596162;8975.102489750972;8598.054214036576;8891.644334226818;8983.595738191667;9014.323925705467;9114.544272786201;6412.743490260337;7194.820129496595;7299.635018249172;7428.182899880901;7463.888041679271;7530.623468826647;7545.320921117126;7598.164201937672;7606.581638009962;7611.923880761122;6512.511561632802;6738.326167383222;6747.763828265987;6872.140982377203;6885.1049363582415;6692.59844409337;6701.53089283765;6701.932980670131;6735.73057077731;6852.383285504328;6199.132121503083;6582.275949645631;6628.5691430056895;6672.165979252593;6679.298673639392;4579.404677391918;4672.18236808564;4751.144793937125;4763.118823017753;4800.615950724004;4730.077634861169;4748.976255118702;4816.927746083741;4836.854894353175;4851.587615052619 23:06:48 INFO - PROCESS | 4887 | |4;prototype.html;319.24020830423586;319.7633751024242;321.24667654350554;326.63253839430627;331.71638249296836;5036.496350364966;5102.948970510299;5104.38747350318;5120.590352771778;5130.769115389807;4998.2752500887345;5022.397312322517;5041.243813427987;5050.974745126269;5060.190369540875;3769.3215221260093;3863.729538932276;3938.172983673432;3971.424143499191;3991.7068418554663;3971.4042893565907;3989.620986006339;4005.0988527581208;4005.4192142139373;4013.8595149169787;3779.9622003779887;3952.881413557598;3962.4254483099935;3974.9205015899665;3983.103801644636;3856.46009558662;3920.7059470539825;3939.6014414882875;3948.0654479304935;3953.5453422856453;3510.4032314506594;3529.611742708326;3534.7525673202886;3535.6034366425374;3543.114221444639;4825.324454576327;4827.686200396963;4842.564169224752;4852.514748525155;4863.221884498464;4338.522762496123;4553.658475614342;4592.5177856324935;4600.470945841238;4611.930821037688;5292.841214763564;5293.788248470057;5301.204819277139;5308.787648494055;5323.946760532383;3729.4219395993664;3891.3384724596604;3896.5129358830145;3896.7272290939645;3900.1224724437056;5508.08071721988;5584.497395234408;5584.972075139639;5595.8880822383735;5604.635698679532;3955.3869150281753;3974.28462876685;3981.9402708959387;3987.7806720630642;3991.5808840071954;4060.4315395844606;4063.2482990646827;4072.450219220367;4072.9185416291507;4088.693347998912;4431.224535706238;4572.954270457253;4580.8163326487775;4586.922073312769;4591.816327346935;5336.1462166054025;5341.501316637531;5345.305110335709;5346.625736198506;5351.143816989263;1399.5871217990716;1412.4773833681604;1414.618053125671;1421.3177674716194;1427.4226979188056;967.2213867836459;977.2816979520047;978.1832170137873;984.0602224875227;991.2020823237219;4717.103750287434;4719.3628860103445;4736.573708366263;4743.905121897612;4745.952540474551;5504.504594586507;5515.889682206413;5519;5530.944690553043;5532.75102620383;4631.62946964242;4725.291206319011;4730.2431610942085;4731.7634118293945;4733.644976626767;2920.985395073011;2921.5033444314518;2924.824510529375;2934.618499595039;2935.544990526472;5189.792408303626;5211.8175863845345;5213.973930130325;5214.296070030573;5223.9477605223465;5410.48600382963;5638.210650508932;5686.857828554319;5695.60130790849;5710.143478478261;5219.321488206509;5232.633715639869;5240.71176085319;5244.108501554745;5253.658512196695;5352.601098302528;5544.3346798384455;5550.389457159628;5555.333359996826;5584.441555844383;5428.538574221236;5431.266778984945;5433.266509021231;5461.426550212171;5471.097268950579;5234.555062819551;5236.5548928339995;5237.947620523746;5239.816606418757;5249.396319423163;3688.170161713593;3891.747036442622;3919.7844118573753;3924.136689928211;3925.9018524535973;5237.371515418175;5358.606762241768;5482.23248745184;5492.5605951524585;5496.203050557727;5327.653702509325;5334.306540149756;5340.225667278145;5342.252084708066;5349.411564727799;5335.73321333924;5352.116900711495;5354.759035843318;5370.066775960573;5374.596905232045;5155.922661160011;5206.245094461357;5279.52484276417;5284.180951952453;5312.840614781563;5367.35591728995;5379.139337706105;5383.7308134593895;5389.083855744611;5401.189821526802;5213.739313034409;5214.32213812202;5230.503102205284;5241.663375839136;5243.213517972335 23:06:48 INFO - PROCESS | 4887 | |5;yui.html;709.7480394459964;720.6288761287934;733.3619750816787;737.3695490355746;744.9106107267127;11107.777844443106;12183.695407614814;12567.183133096343;12597.181183223083;12644.620661380173;13070.934645326784;13108.147970381919;13118.278494682812;13171.078024538287;13184;640.3180612647539;814.3566582399897;820.3683163963744;821.0434843407423;821.6261600971574;650.2879347114925;655.4821690864212;655.5607742812304;778.649607676545;808.5552945879772;843.3253397282181;845.6659619450344;848.8387206430789;848.893888263967;850.0479463001416;836.7908022994252;840.3025488844306;840.4075127035455;840.4327079221562;840.7393707950524;490.25970784115884;597.2623809595146;609.8780243951228;611.034565386688;611.6605284067341;11828.88171118295;11900.702482437922;11936.761264774656;11963.102767292488;11967.1622986391;11366.659000230007;12088.879111208864;12175.634730958085;12187.146899717023;12364.814527782091;9941.75145621358;9951.452670103141;10015.849762253572;10049.196064314838;10389.532471038821;3268.4280250956226;3294.4399452093203;3307.834608269577;3310.3875782980226;3350.6816852398983;47356.763216183695;47395;47824.04351912977;47849.5215047852;47993.5200647996;9809.11717945374;9863;9901.455419951972;9930.657387846402;10061.346012509164;15884.52346429609;17132.48602541901;17195.656086878193;17231.913840430716;17272.481825545256;6767.221769496472;6880.2431732509385;6895.448364130857;6947.4789390795895;7033.613151276627;3766.642168993996;3926.2540117377607;3994.6205110514456;4008.6392224699334;4009.2983727848095;2871.239121632769;2969.1834745445176;2971.8216906985217;2980.821150730963;2986.134021133847;527.8047122564676;529.9629025968222;536.8174820561028;540.924270602116;541.1368866657675;440.7597859166762;491.9262110683355;520.3287758791192;545.6862901298466;546.7594258526316;7336.96331518339;7509.7371591994015;7688.115866675292;7812.765617031499;7812.921870781333;526.5497999210696;537.1459379586477;628.5819929746758;636.748484348689;638.2659941067809;3656.926861462756;3859.305325041463;3889.8249578769023;3895.3334762386266;3954.6045395460224;44708;46030;46100.7694961523;53582;53735.92528149415;39345.40981885274;39509.80245098756;39642.80178599089;44117;44129.77935110304;38750;39439;39946.600533994286;40036.19927601432;40433.1913361737;7575;7592.582407967615;7661.502002369828;7751.263629955145;7815.941099560922;28584.42831143324;28635.14094577166;28719.582390536732;28806.567901481074;29596.408071838014;35553.1111722209;37271.81364093162;37278.8136059318;37689;38013;9595.856062159213;9600.847512165528;9744.269179811685;9775.902240977499;9806.950965245129;10549.578016879546;10910.454477276264;10952.809438112568;11001.17491188148;11068.28056176346;10814.35113893169;10985.890141098487;11030.779384412428;11218.55125794959;11242.606508772154;10733.677989660322;10965.83551246716;11462.312261264351;11463.140264480364;11481.36852473122;10005.849912251177;10464.058234758908;10576.629817956335;10964.780704385708;10992.670219893416;8903.554822258991;8916.86624700617;9062.410943288665;9104.90895091067;9412.576434060347;9239.907600924174;9312.860307095263;9432.764180895532;9445.905540944503;9451.149396554343 23:06:48 INFO - PROCESS | 4887 | __end_tp_report 23:06:48 INFO - PROCESS | 4887 | __start_cc_report 23:06:48 INFO - PROCESS | 4887 | _x_x_mozilla_cycle_collect,1141 23:06:48 INFO - PROCESS | 4887 | __end_cc_report 23:06:48 INFO - PROCESS | 4887 | __startTimestamp1460700408874__endTimestamp 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | ------- Summary: start ------- 23:06:48 INFO - PROCESS | 4887 | Number of tests: 6 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#0] dojo.html Cycles:165 Average:4628.11 Median:4761.69 stddev:472.53 (9.9%) stddev-sans-first:447.26 23:06:48 INFO - PROCESS | 4887 | Values: 2631.0 2690.3 2694.2 2698.5 2721.6 4600.2 4635.7 4649.2 4665.8 4688.6 4612.4 4630.1 4702.9 4713.8 4721.4 4304.6 4335.7 4338.9 4389.3 4411.5 4344.5 4354.4 4387.5 4413.7 4419.4 4256.5 4312.8 4340.5 4382.6 4388.8 4232.9 4243.7 4255.6 4265.1 4265.4 4208.1 4208.4 4213.9 4216.3 4221.6 4492.0 4497.8 4508.3 4527.6 4597.1 4983.0 5003.4 5016.1 5019.6 5020.0 4998.4 5009.5 5012.6 5050.1 5066.5 4556.1 4660.9 4661.3 4726.1 4737.1 5034.3 5076.9 5078.3 5079.4 5087.1 4884.0 4889.1 4890.0 4891.4 4935.8 4877.7 5000.0 5049.7 5077.0 5098.7 4951.7 4969.9 4975.3 4978.7 5025.8 4851.4 4959.8 4968.6 4971.5 5019.6 4220.6 4222.6 4229.0 4283.8 4298.4 3681.4 3703.2 3708.9 3743.5 3747.8 4361.9 4362.8 4366.1 4369.2 4406.3 4861.8 4999.0 5059.5 5071.6 5097.1 4346.8 4350.5 4364.2 4365.3 4407.2 4435.1 4528.4 4529.8 4531.5 4573.2 4743.0 4786.6 4791.0 4821.4 4831.4 4987.2 4988.2 5026.6 5029.6 5084.9 4629.9 4741.9 4753.5 4761.7 4800.4 4949.8 4969.3 4971.3 4975.1 5024.4 5003.2 5038.4 5039.4 5041.2 5100.5 4741.1 4828.1 4890.7 4912.5 4945.0 4863.9 4888.2 4895.2 4917.8 4934.2 4790.5 4809.2 4817.5 4835.3 4884.1 4720.6 4821.9 4824.2 4894.4 4919.9 4686.7 4780.3 4786.7 4791.0 4809.9 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#1] ext.html Cycles:180 Average:38655.45 Median:34435.07 stddev:64394.72 (187.0%) stddev-sans-first:64511.86 23:06:48 INFO - PROCESS | 4887 | Values: 568.4 604.9 605.6 615.0 631.5 26084.7 33853.2 34992.5 35017.5 35031.8 39480.0 40167.2 40299.6 40308.0 40396.0 7761.5 7935.4 7946.4 7956.4 7956.9 7657.1 7801.9 7812.5 7816.3 7818.8 7834.2 7843.6 7856.8 7894.2 7899.4 7777.5 7818.8 7830.0 7832.2 7835.8 7774.6 7891.8 7894.2 7898.0 7905.5 34568.5 34872.1 34899.3 34915.1 34991.1 2907.6 3038.6 3184.2 3259.0 3369.4 28131.3 28778.7 28864.0 28975.4 29463.9 3417.5 3446.2 3492.9 3509.5 3524.3 173500.0 173644.0 174062.0 174275.0 174811.0 33587.3 49779.3 51566.7 51600.5 51622.0 33706.8 33958.2 33988.0 34004.5 34018.3 13189.5 13340.3 13348.3 13355.5 13355.5 9903.4 9917.2 9922.9 9989.0 10006.4 8116.5 8127.4 8152.8 8202.7 8204.1 3152.2 3200.8 3205.9 3252.2 3267.6 934.7 981.5 987.7 1021.1 1074.6 27862.4 27900.7 28361.0 28437.7 28522.7 1009.5 1027.6 1040.7 1082.4 1117.8 14731.0 14988.6 15052.4 15239.7 15376.5 335595.0 339146.0 341644.0 341843.0 342122.0 47434.0 48185.8 48251.0 48316.3 48409.0 1043.4 1141.5 1162.0 1224.1 1260.5 25516.7 27538.0 27638.4 27866.6 27980.9 39001.8 39337.2 39349.4 39531.6 39588.0 182319.0 183874.0 184400.0 184528.0 185120.0 24888.8 33879.7 37533.6 37572.4 38949.8 37361.6 37683.8 37794.0 37871.4 38275.0 34196.7 34264.8 34340.7 34458.3 34976.3 34211.3 34577.5 34606.7 34710.3 34856.8 34020.3 34177.7 34411.8 36756.6 38127.6 29492.4 31099.0 31434.8 31506.0 31659.8 24220.3 24542.8 24615.4 24927.9 25013.6 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#2] jquery.html Cycles:180 Average:23803.63 Median:25808.91 stddev:63303.33 (245.3%) stddev-sans-first:63456.45 23:06:48 INFO - PROCESS | 4887 | Values: 368.4 369.4 392.7 395.3 397.2 15934.8 17777.4 17853.8 17969.6 18003.7 16611.0 16880.6 17054.4 17437.2 17490.8 5085.2 5211.1 5237.0 5255.7 5258.3 3726.8 3995.9 5464.4 5917.9 5930.8 5619.0 5826.6 5831.1 5833.6 5855.6 5782.5 5796.9 5876.8 5892.5 5892.9 5116.8 5276.1 5276.1 5278.2 5285.3 20203.9 20327.1 20688.4 20828.6 20956.2 1771.0 1956.2 2004.6 2013.5 2093.8 9253.9 9457.5 9571.7 12579.0 12686.7 1712.2 1717.9 1730.7 1768.5 1804.2 51357.5 54734.2 60641.7 66359.7 69323.3 9678.0 9803.6 9885.5 9936.3 10000.9 13334.7 13454.7 13491.6 13510.9 13561.0 7337.9 7394.6 7481.3 7543.0 7544.4 7050.8 7183.3 7199.2 7282.3 7332.2 4057.6 4255.3 4399.2 4412.7 4512.8 1750.8 1846.4 1880.5 1904.9 1954.3 816.5 874.8 880.3 886.2 895.5 16155.4 16901.8 17065.7 17336.3 17384.1 871.4 889.7 904.5 933.4 953.6 9117.4 9205.4 9575.3 9695.4 9840.5 378376.0 382731.0 384435.0 385258.0 389561.0 76632.2 79993.6 80114.2 80392.6 80889.9 843.2 905.3 931.8 948.9 963.4 14639.1 14759.4 14847.5 14874.8 15285.2 31803.2 32329.7 33496.2 33588.3 33619.2 47105.0 47190.5 47204.1 47358.1 47998.5 7709.9 7779.8 7883.6 7895.8 7913.0 10409.9 10793.9 10796.1 10879.4 10946.2 10084.7 10184.1 10333.8 10348.7 10615.3 9241.2 9593.4 10005.5 10184.1 10244.7 10422.8 10467.2 10568.4 10674.2 10941.8 7598.6 7705.5 7747.0 7765.5 7793.1 9411.7 9713.6 10196.1 10267.4 10298.3 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#3] mootools.html Cycles:180 Average:5209.47 Median:5145.35 stddev:2832.16 (55.0%) stddev-sans-first:2824.93 23:06:48 INFO - PROCESS | 4887 | Values: 1309.1 1413.6 1469.2 1559.2 1767.1 6856.0 7601.2 7871.3 7876.6 7894.9 7544.6 7712.0 7758.3 7762.4 7774.3 1886.4 2137.0 2186.1 2211.2 2219.8 2260.5 2278.3 2278.4 2281.7 2288.8 2182.5 2230.6 2231.1 2233.6 2234.6 1860.7 2172.8 2261.6 2264.8 2268.2 2192.9 2198.4 2214.1 2217.7 2244.7 7704.5 7775.7 7778.6 7791.2 7796.0 4523.8 4719.7 4726.4 4737.5 4759.0 2997.6 3062.3 3083.3 3170.5 3201.0 1033.9 1056.7 1064.2 1066.2 1084.8 10344.6 10610.8 10647.1 10674.3 10678.1 4223.5 4294.2 4382.9 4412.2 4420.2 9247.2 9255.9 9274.6 9282.6 9285.1 4183.5 4690.9 4697.2 4698.6 4714.8 4120.5 4158.4 4214.3 4221.1 4221.5 3695.6 3741.5 3807.4 3838.7 3881.5 1221.2 1227.7 1243.6 1248.4 1258.4 785.5 850.7 895.0 895.2 909.6 5474.5 5654.0 5675.4 5774.3 5842.4 934.0 937.8 965.2 969.9 1006.4 3700.6 3861.5 3867.8 3880.3 3971.1 9157.1 9367.4 9411.3 9458.2 9541.6 9346.8 9394.8 9396.9 9404.2 9450.8 7131.8 7236.8 7258.9 7291.1 7333.1 5439.1 5535.0 5575.9 5609.7 5746.4 8700.3 8796.4 8838.0 8953.8 8975.1 8598.1 8891.6 8983.6 9014.3 9114.5 6412.7 7194.8 7299.6 7428.2 7463.9 7530.6 7545.3 7598.2 7606.6 7611.9 6512.5 6738.3 6747.8 6872.1 6885.1 6692.6 6701.5 6701.9 6735.7 6852.4 6199.1 6582.3 6628.6 6672.2 6679.3 4579.4 4672.2 4751.1 4763.1 4800.6 4730.1 4749.0 4816.9 4836.9 4851.6 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#4] prototype.html Cycles:180 Average:4450.63 Median:5081.57 stddev:1279.86 (25.2%) stddev-sans-first:1245.32 23:06:48 INFO - PROCESS | 4887 | Values: 319.2 319.8 321.2 326.6 331.7 5036.5 5102.9 5104.4 5120.6 5130.8 4998.3 5022.4 5041.2 5051.0 5060.2 3769.3 3863.7 3938.2 3971.4 3991.7 3971.4 3989.6 4005.1 4005.4 4013.9 3780.0 3952.9 3962.4 3974.9 3983.1 3856.5 3920.7 3939.6 3948.1 3953.5 3510.4 3529.6 3534.8 3535.6 3543.1 4825.3 4827.7 4842.6 4852.5 4863.2 4338.5 4553.7 4592.5 4600.5 4611.9 5292.8 5293.8 5301.2 5308.8 5323.9 3729.4 3891.3 3896.5 3896.7 3900.1 5508.1 5584.5 5585.0 5595.9 5604.6 3955.4 3974.3 3981.9 3987.8 3991.6 4060.4 4063.2 4072.5 4072.9 4088.7 4431.2 4573.0 4580.8 4586.9 4591.8 5336.1 5341.5 5345.3 5346.6 5351.1 1399.6 1412.5 1414.6 1421.3 1427.4 967.2 977.3 978.2 984.1 991.2 4717.1 4719.4 4736.6 4743.9 4746.0 5504.5 5515.9 5519.0 5530.9 5532.8 4631.6 4725.3 4730.2 4731.8 4733.6 2921.0 2921.5 2924.8 2934.6 2935.5 5189.8 5211.8 5214.0 5214.3 5223.9 5410.5 5638.2 5686.9 5695.6 5710.1 5219.3 5232.6 5240.7 5244.1 5253.7 5352.6 5544.3 5550.4 5555.3 5584.4 5428.5 5431.3 5433.3 5461.4 5471.1 5234.6 5236.6 5237.9 5239.8 5249.4 3688.2 3891.7 3919.8 3924.1 3925.9 5237.4 5358.6 5482.2 5492.6 5496.2 5327.7 5334.3 5340.2 5342.3 5349.4 5335.7 5352.1 5354.8 5370.1 5374.6 5155.9 5206.2 5279.5 5284.2 5312.8 5367.4 5379.1 5383.7 5389.1 5401.2 5213.7 5214.3 5230.5 5241.7 5243.2 23:06:48 INFO - PROCESS | 4887 | 23:06:48 INFO - PROCESS | 4887 | [#5] yui.html Cycles:180 Average:12338.55 Median:45369.00 stddev:13742.83 (30.3%) stddev-sans-first:13753.63 23:06:48 INFO - PROCESS | 4887 | Values: 709.7 720.6 733.4 737.4 744.9 11107.8 12183.7 12567.2 12597.2 12644.6 13070.9 13108.1 13118.3 13171.1 13184.0 640.3 814.4 820.4 821.0 821.6 650.3 655.5 655.6 778.6 808.6 843.3 845.7 848.8 848.9 850.0 836.8 840.3 840.4 840.4 840.7 490.3 597.3 609.9 611.0 611.7 11828.9 11900.7 11936.8 11963.1 11967.2 11366.7 12088.9 12175.6 12187.1 12364.8 9941.8 9951.5 10015.8 10049.2 10389.5 3268.4 3294.4 3307.8 3310.4 3350.7 47356.8 47395.0 47824.0 47849.5 47993.5 9809.1 9863.0 9901.5 9930.7 10061.3 15884.5 17132.5 17195.7 17231.9 17272.5 6767.2 6880.2 6895.4 6947.5 7033.6 3766.6 3926.3 3994.6 4008.6 4009.3 2871.2 2969.2 2971.8 2980.8 2986.1 527.8 530.0 536.8 540.9 541.1 440.8 491.9 520.3 545.7 546.8 7337.0 7509.7 7688.1 7812.8 7812.9 526.5 537.1 628.6 636.7 638.3 3656.9 3859.3 3889.8 3895.3 3954.6 44708.0 46030.0 46100.8 53582.0 53735.9 39345.4 39509.8 39642.8 44117.0 44129.8 38750.0 39439.0 39946.6 40036.2 40433.2 7575.0 7592.6 7661.5 7751.3 7815.9 28584.4 28635.1 28719.6 28806.6 29596.4 35553.1 37271.8 37278.8 37689.0 38013.0 9595.9 9600.8 9744.3 9775.9 9807.0 10549.6 10910.5 10952.8 11001.2 11068.3 10814.4 10985.9 11030.8 11218.6 11242.6 10733.7 10965.8 11462.3 11463.1 11481.4 10005.8 10464.1 10576.6 10964.8 10992.7 8903.6 8916.9 9062.4 9104.9 9412.6 9239.9 9312.9 9432.8 9445.9 9451.1 23:06:48 INFO - PROCESS | 4887 | -------- Summary: end -------- 23:06:48 INFO - PROCESS | 4887 | 23:06:49 INFO - TEST-INFO | 4887: exit 0 23:06:49 INFO - TEST-OK | dromaeo_css | took 1118503ms 23:06:49 INFO - TEST-START | kraken 23:06:49 INFO - operating with platform_type : linux_ 23:06:49 INFO - Initialising browser for kraken test... 23:06:49 INFO - TEST-INFO | started process 5062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWUnZxM/profile http://localhost:59306/getInfo.html) 23:06:53 INFO - PROCESS | 5062 | __metrics Screen width/height:1600/1200 23:06:53 INFO - PROCESS | 5062 | colorDepth:24 23:06:53 INFO - PROCESS | 5062 | Browser inner width/height: 1024/697 23:06:53 INFO - PROCESS | 5062 | __metrics 23:06:54 ERROR - PROCESS | 5062 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:06:55 INFO - TEST-INFO | 5062: exit 0 23:06:55 INFO - Browser initialized. 23:06:55 INFO - Running cycle 1/1 for kraken test... 23:06:55 INFO - TEST-INFO | started process 5145 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWUnZxM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:07:07 INFO - PROCESS | 5145 | RSS: Main: 154140672 23:07:07 INFO - PROCESS | 5145 | 23:07:10 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59306/tests/kraken/driver.html?testName=audio-beat-detection) 23:07:11 INFO - PROCESS | 5145 | RSS: Main: 209608704 23:07:11 INFO - PROCESS | 5145 | 23:07:13 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59306/tests/kraken/driver.html?testName=audio-dft) 23:07:14 INFO - PROCESS | 5145 | RSS: Main: 195252224 23:07:14 INFO - PROCESS | 5145 | 23:07:17 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59306/tests/kraken/driver.html?testName=audio-fft) 23:07:18 INFO - PROCESS | 5145 | RSS: Main: 266305536 23:07:18 INFO - PROCESS | 5145 | 23:07:20 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59306/tests/kraken/driver.html?testName=audio-oscillator) 23:07:21 INFO - PROCESS | 5145 | RSS: Main: 174243840 23:07:21 INFO - PROCESS | 5145 | 23:07:23 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59306/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:07:23 INFO - PROCESS | 5145 | RSS: Main: 178454528 23:07:23 INFO - PROCESS | 5145 | 23:07:27 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59306/tests/kraken/driver.html?testName=imaging-darkroom) 23:07:27 INFO - PROCESS | 5145 | RSS: Main: 214495232 23:07:27 INFO - PROCESS | 5145 | 23:07:31 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59306/tests/kraken/driver.html?testName=imaging-desaturate) 23:07:31 INFO - PROCESS | 5145 | RSS: Main: 215109632 23:07:31 INFO - PROCESS | 5145 | 23:07:34 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59306/tests/kraken/driver.html?testName=json-parse-financial) 23:07:35 INFO - PROCESS | 5145 | RSS: Main: 214847488 23:07:35 INFO - PROCESS | 5145 | 23:07:36 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59306/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:07:37 INFO - PROCESS | 5145 | RSS: Main: 201752576 23:07:37 INFO - PROCESS | 5145 | 23:07:39 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:07:39 INFO - PROCESS | 5145 | RSS: Main: 205213696 23:07:39 INFO - PROCESS | 5145 | 23:07:42 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:07:42 INFO - PROCESS | 5145 | RSS: Main: 218021888 23:07:42 INFO - PROCESS | 5145 | 23:07:45 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:07:46 INFO - PROCESS | 5145 | RSS: Main: 225341440 23:07:46 INFO - PROCESS | 5145 | 23:07:49 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:07:49 INFO - PROCESS | 5145 | RSS: Main: 219750400 23:07:49 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | Cycle 1(1): loaded http://localhost:59306/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59306/tests/kraken/driver.html?testName=ai-astar) 23:07:51 INFO - PROCESS | 5145 | RSS: Main: 282386432 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | __start_tp_report 23:07:51 INFO - PROCESS | 5145 | _x_x_mozilla_page_load 23:07:51 INFO - PROCESS | 5145 | _x_x_mozilla_page_load_details 23:07:51 INFO - PROCESS | 5145 | |i|pagename|runs| 23:07:51 INFO - PROCESS | 5145 | |0;ai-astar;111;112;107;113;112;113;102;111;113;111 23:07:51 INFO - PROCESS | 5145 | |1;audio-beat-detection;158;131;154;182;132;158;156;136;183;132 23:07:51 INFO - PROCESS | 5145 | |2;audio-dft;162;164;161;158;162;160;160;163;160;162 23:07:51 INFO - PROCESS | 5145 | |3;audio-fft;73;73;111;110;75;74;73;121;110;74 23:07:51 INFO - PROCESS | 5145 | |4;audio-oscillator;93;93;144;93;93;93;147;93;93;141 23:07:51 INFO - PROCESS | 5145 | |5;imaging-gaussian-blur;117;117;117;116;117;117;117;117;117;117 23:07:51 INFO - PROCESS | 5145 | |6;imaging-darkroom;146;146;145;145;146;146;146;146;147;146 23:07:51 INFO - PROCESS | 5145 | |7;imaging-desaturate;95;96;96;96;95;96;95;95;96;95 23:07:51 INFO - PROCESS | 5145 | |8;json-parse-financial;64;65;65;65;66;65;65;80;63;74 23:07:51 INFO - PROCESS | 5145 | |9;json-stringify-tinderbox;65;65;64;64;66;65;67;65;65;65 23:07:51 INFO - PROCESS | 5145 | |10;stanford-crypto-aes;83;84;83;85;82;86;84;84;84;84 23:07:51 INFO - PROCESS | 5145 | |11;stanford-crypto-ccm;145;137;135;137;133;137;136;146;177;147 23:07:51 INFO - PROCESS | 5145 | |12;stanford-crypto-pbkdf2;173;171;175;174;172;172;171;170;169;171 23:07:51 INFO - PROCESS | 5145 | |13;stanford-crypto-sha256-iterative;78;71;69;73;76;74;70;70;70;71 23:07:51 INFO - PROCESS | 5145 | __end_tp_report 23:07:51 INFO - PROCESS | 5145 | __start_cc_report 23:07:51 INFO - PROCESS | 5145 | _x_x_mozilla_cycle_collect,1859 23:07:51 INFO - PROCESS | 5145 | __end_cc_report 23:07:51 INFO - PROCESS | 5145 | __startTimestamp1460700471759__endTimestamp 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | ------- Summary: start ------- 23:07:51 INFO - PROCESS | 5145 | Number of tests: 14 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.47 (3.1%) stddev-sans-first:3.68 23:07:51 INFO - PROCESS | 5145 | Values: 111.0 112.0 107.0 113.0 112.0 113.0 102.0 111.0 113.0 111.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#1] audio-beat-detection Cycles:10 Average:152.20 Median:157.00 stddev:19.58 (12.5%) stddev-sans-first:20.65 23:07:51 INFO - PROCESS | 5145 | Values: 158.0 131.0 154.0 182.0 132.0 158.0 156.0 136.0 183.0 132.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#2] audio-dft Cycles:10 Average:161.20 Median:162.00 stddev:1.75 (1.1%) stddev-sans-first:1.83 23:07:51 INFO - PROCESS | 5145 | Values: 162.0 164.0 161.0 158.0 162.0 160.0 160.0 163.0 160.0 162.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#3] audio-fft Cycles:10 Average:89.40 Median:73.00 stddev:20.55 (28.2%) stddev-sans-first:20.93 23:07:51 INFO - PROCESS | 5145 | Values: 73.0 73.0 111.0 110.0 75.0 74.0 73.0 121.0 110.0 74.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#4] audio-oscillator Cycles:10 Average:108.30 Median:93.00 stddev:24.68 (26.5%) stddev-sans-first:25.54 23:07:51 INFO - PROCESS | 5145 | Values: 93.0 93.0 144.0 93.0 93.0 93.0 147.0 93.0 93.0 141.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 23:07:51 INFO - PROCESS | 5145 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 23:07:51 INFO - PROCESS | 5145 | Values: 146.0 146.0 145.0 145.0 146.0 146.0 146.0 146.0 147.0 146.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 23:07:51 INFO - PROCESS | 5145 | Values: 95.0 96.0 96.0 96.0 95.0 96.0 95.0 95.0 96.0 95.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#8] json-parse-financial Cycles:10 Average:67.20 Median:65.00 stddev:5.41 (8.3%) stddev-sans-first:5.61 23:07:51 INFO - PROCESS | 5145 | Values: 64.0 65.0 65.0 65.0 66.0 65.0 65.0 80.0 63.0 74.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#9] json-stringify-tinderbox Cycles:10 Average:65.10 Median:65.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 23:07:51 INFO - PROCESS | 5145 | Values: 65.0 65.0 64.0 64.0 66.0 65.0 67.0 65.0 65.0 65.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.10 (1.3%) stddev-sans-first:1.12 23:07:51 INFO - PROCESS | 5145 | Values: 83.0 84.0 83.0 85.0 82.0 86.0 84.0 84.0 84.0 84.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:141.00 stddev:12.94 (9.2%) stddev-sans-first:13.70 23:07:51 INFO - PROCESS | 5145 | Values: 145.0 137.0 135.0 137.0 133.0 137.0 136.0 146.0 177.0 147.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.80 Median:172.00 stddev:1.81 (1.1%) stddev-sans-first:1.87 23:07:51 INFO - PROCESS | 5145 | Values: 173.0 171.0 175.0 174.0 172.0 172.0 171.0 170.0 169.0 171.0 23:07:51 INFO - PROCESS | 5145 | 23:07:51 INFO - PROCESS | 5145 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.20 Median:72.00 stddev:2.97 (4.1%) stddev-sans-first:2.30 23:07:51 INFO - PROCESS | 5145 | Values: 78.0 71.0 69.0 73.0 76.0 74.0 70.0 70.0 70.0 71.0 23:07:51 INFO - PROCESS | 5145 | -------- Summary: end -------- 23:07:51 INFO - PROCESS | 5145 | 23:07:52 INFO - TEST-INFO | 5145: exit 0 23:07:52 INFO - TEST-OK | kraken | took 63198ms 23:07:52 INFO - SUITE-END | took 1181s 23:07:52 INFO - Completed test suite (00:19:41) 23:07:52 INFO - javascript benchmark 23:07:52 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2630.9736902630975, 2690.260178450927, 2694.205209463208, 2698.5142674318627, 2721.564549672052, 4600.194965880974, 4635.675502714807, 4649.209634362158, 4665.813367465297, 4688.648351373652, 4612.400387949562, 4630.143423466652, 4702.929456058153, 4713.811447542094, 4721.362616046833, 4304.5695430456935, 4335.739855608674, 4338.913221735579, 4389.253826849444, 4411.514733379326, 4344.478662560481, 4354.412154359153, 4387.473503179623, 4413.668974826885, 4419.447569053868, 4256.531781504032, 4312.805923733439, 4340.500842403132, 4382.583654552813, 4388.780560971939, 4232.894177645583, 4243.6605071594195, 4255.5744425557505, 4265.104328091104, 4265.44549208604, 4208.0952595191875, 4208.410822484854, 4213.91572168558, 4216.2832318505925, 4221.598948099926, 4492.034212644297, 4497.7526236057, 4508.278675411918, 4527.569880861313, 4597.126545956257, 4983.0, 5003.424606170264, 5016.147254966664, 5019.64862459628, 5019.974900125512, 4998.350214472095, 5009.499050094998, 5012.573931215815, 5050.065737838511, 5066.46802085783, 4556.134334476439, 4660.930086048712, 4661.277501987163, 4726.125666751662, 4737.147313483537, 5034.320366750515, 5076.949230507647, 5078.314427552307, 5079.3650793650795, 5087.084324821568, 4883.975580122148, 4889.071076495455, 4889.951100489021, 4891.437484689235, 4935.7532123393685, 4877.731724755102, 4999.950000500021, 5049.747512624354, 5077.0, 5098.745062746848, 4951.653384263139, 4969.90060198794, 4975.328330675313, 4978.701277923336, 5025.773840177128, 4851.393575803025, 4959.752012399365, 4968.552830245295, 4971.45314015458, 5019.623528235397, 4220.556841531657, 4222.619964203236, 4229.0, 4283.785810709452, 4298.398224248608, 3681.37416639172, 3703.2408356286896, 3708.851645934132, 3743.494628225155, 3747.775133491999, 4361.869143925687, 4362.8036738346855, 4366.061296821199, 4369.235383807821, 4406.27296496081, 4861.756912154449, 4999.02519008797, 5059.519345662156, 5071.594272458195, 5097.057044446789, 4346.8043938022865, 4350.499692535335, 4364.192624364503, 4365.301551751768, 4407.206702793464, 4435.090806384684, 4528.388667529907, 4529.818807247673, 4531.501534831166, 4573.245414506636, 4742.976285118552, 4786.641001924939, 4790.952090479051, 4821.421429428491, 4831.396075490564, 4987.177115775857, 4988.226824842155, 5026.648134630541, 5029.572486338702, 5084.923726144185, 4629.93055104167, 4741.881452963704, 4753.5008824072975, 4761.6904901181315, 4800.375951126471, 4949.802007919643, 4969.279454479152, 4971.279164521196, 4975.0547395994645, 5024.371953505812, 5003.199488081889, 5038.39539255277, 5039.445660977216, 5041.193409054534, 5100.5409513143995, 4741.051789642016, 4828.058528586892, 4890.682105663121, 4912.533309335608, 4944.975275123746, 4863.90272194547, 4888.2178851383605, 4895.167821470287, 4917.803287868445, 4934.185859333314, 4790.520947905321, 4809.2064809306075, 4817.470078291455, 4835.274708793709, 4884.096442158212, 4720.598749106227, 4821.927671085006, 4824.228123500223, 4894.388201474816, 4919.926201107058, 4686.718796872198, 4780.330753694555, 4786.664933454764, 4790.976045119752, 4809.855704328876], "value": 4599.058569750433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.4031766645022, 604.9021026836294, 605.5518916002158, 614.9576467886933, 631.5484428633526, 26084.73915260847, 33853.1536711582, 34992.475112873326, 35017.474737878954, 35031.82484087579, 39480.0, 40167.19665606686, 40299.59700402995, 40308.0, 40396.0, 7761.534307941542, 7935.404844636647, 7946.404019698517, 7956.443048986574, 7956.880646790303, 7657.11943126542, 7801.882971755428, 7812.453128281023, 7816.335611473031, 7818.804529886742, 7834.177411371809, 7843.607819609026, 7856.7642970710685, 7894.2105789421175, 7899.447038707292, 7777.494462859896, 7818.843623127563, 7830.021247344082, 7832.216778322179, 7835.843283134305, 7774.572398518079, 7891.842163156704, 7894.2105789421175, 7897.960510197469, 7905.486143400661, 34568.48147277793, 34872.12819679503, 34899.302013959576, 34915.12712182216, 34991.1252218694, 2907.636545431821, 3038.5745995560637, 3184.2357834119875, 3259.0, 3369.444041733111, 28131.29671758202, 28778.712212877814, 28864.0, 28975.42049159026, 29463.852680736458, 3417.4532074868152, 3446.2418267981, 3492.947605785915, 3509.5262139611336, 3524.2599054198395, 173500.0, 173644.0, 174062.0, 174275.0, 174811.0, 33587.328253435284, 49779.25331120036, 51566.74216628893, 51600.48399516032, 51622.0, 33706.831465842515, 33958.15104622404, 33988.0, 34004.48993265103, 34018.31963360719, 13189.538366157138, 13340.266285354204, 13348.332583370793, 13355.46578136883, 13355.53255636048, 9903.356281841658, 9917.206623470249, 9922.851157232648, 9989.0, 10006.449645269435, 8116.472429292077, 8127.3904457165945, 8152.796180095545, 8202.671893124327, 8204.097549269576, 3152.2417884351194, 3200.8399580020905, 3205.8557364918634, 3252.219467327824, 3267.607887053521, 934.6962237272913, 981.5337714585514, 987.6987518806833, 1021.1320377679062, 1074.6453670288786, 27862.442751144863, 27900.72099278981, 28361.0, 28437.715622843505, 28522.71477285242, 1009.4548943570389, 1027.5974830302641, 1040.675043236851, 1082.3668154129923, 1117.7987962166726, 14731.0, 14988.625284367978, 15052.441085015573, 15239.743054312537, 15376.53870383868, 335595.0, 339146.0, 341644.0, 341843.0, 342122.0, 47434.0, 48185.75907120442, 48251.0, 48316.27525587119, 48409.0, 1043.4052590023614, 1141.4635121492886, 1162.035510526261, 1224.0697070226693, 1260.4727521319696, 25516.744832551438, 27538.0, 27638.447231054863, 27866.58200126959, 27980.86009569939, 39001.804990974866, 39337.213255734154, 39349.409758853064, 39531.61639342609, 39588.0, 182319.0, 183874.0, 184400.0, 184528.0, 185120.0, 24888.751112488644, 33879.661203388634, 37533.62466375301, 37572.43641345327, 38949.8052509747, 37361.62638373581, 37683.81158094192, 37794.0, 37871.43192852165, 38275.0, 34196.65803341935, 34264.82867585746, 34340.656593434745, 34458.310833782685, 34976.30047399089, 34211.31577368389, 34577.48133778045, 34606.65393346135, 34710.30579388449, 34856.82571587126, 34020.31959360749, 34177.65822341844, 34411.82794086014, 36756.632433675324, 38127.618723812404, 29492.410151797274, 31099.0, 31434.842825785723, 31506.0, 31659.84170079135, 24220.254521630257, 24542.75457245476, 24615.38461538476, 24927.875360623082, 25013.624795627715], "value": 15918.315219069858, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3590552438756, 369.44767572479145, 392.70547089682736, 395.33583579586286, 397.24126917587415, 15934.760978585316, 17777.37779177729, 17853.821461785377, 17969.550761230992, 18003.729944050818, 16611.0, 16880.577985550368, 17054.403095891645, 17437.21532531036, 17490.82509174908, 5085.211792172219, 5211.088059589576, 5236.973815130938, 5255.710935898524, 5258.2638430619745, 3726.7577607455564, 3995.8601448949294, 5464.352260468761, 5917.9408205918035, 5930.762769489215, 5619.044762390383, 5826.6212696174825, 5831.096180092092, 5833.591648584579, 5855.648661080328, 5782.479576838084, 5796.942030579704, 5876.764929402819, 5892.499137573312, 5892.880352732967, 5116.846494605168, 5276.050310944029, 5276.076686579833, 5278.181881808326, 5285.2600635911, 20203.898980505004, 20327.085281162235, 20688.379348619565, 20828.58342833135, 20956.16175352984, 1770.97343539847, 1956.2077358669762, 2004.5690176611952, 2013.496625843539, 2093.7801530839347, 9253.889533255984, 9457.527123643791, 9571.664991725325, 12579.0, 12686.746265074647, 1712.1695977450927, 1717.9484615461556, 1730.7403889416562, 1768.522498925283, 1804.2422182683304, 51357.48642513564, 54734.17898731522, 60641.6967915162, 66359.66820165869, 69323.3067669327, 9678.0, 9803.607855685692, 9885.456299903575, 9936.304458687822, 10000.899990999997, 13334.666633334244, 13454.663633409244, 13491.595252142255, 13510.86489135096, 13561.0, 7337.88993165103, 7394.630268486661, 7481.289277518627, 7542.962285188539, 7544.358729507943, 7050.788476345718, 7183.281671832775, 7199.2080871104135, 7282.271772822675, 7332.156801967842, 4057.5739547347694, 4255.29787585045, 4399.23013472641, 4412.713173643703, 4512.81948722054, 1750.8336708012719, 1846.3999200259968, 1880.45802441999, 1904.9047547622563, 1954.3159894036974, 816.4774544291658, 874.8206617643368, 880.2825697056878, 886.1625763653286, 895.4671970177734, 16155.353785848434, 16901.830981690273, 17065.658686826195, 17336.30654773795, 17384.130793460277, 871.4030888841164, 889.6886089868494, 904.4663648447447, 933.3606479561522, 953.5994882149514, 9117.36178467501, 9205.355625106313, 9575.281853860988, 9695.351790195684, 9840.458774767456, 378376.0, 382731.0, 384435.0, 385258.0, 389561.0, 76632.23367766362, 79993.60003199946, 80114.19885801183, 80392.59803700945, 80889.89163368035, 843.1913545444986, 905.298393744853, 931.7903471718809, 948.9383190092622, 963.4171326347599, 14639.121652700445, 14759.409623615365, 14847.480338188112, 14874.77687834705, 15285.159316237714, 31803.20491987719, 32329.676703232668, 33496.1625959353, 33588.328233435685, 33619.15952101217, 47105.0, 47190.52809471861, 47204.055918880746, 47358.05283894234, 47998.5200148008, 7709.922900771145, 7779.844403112019, 7883.605819709106, 7895.84208315819, 7912.960435197787, 10409.9479502602, 10793.892061079603, 10796.082333001468, 10879.401632910265, 10946.17903657213, 10084.747881303027, 10184.083432491112, 10333.793324133325, 10348.741281468023, 10615.31000484966, 9241.168294853496, 9593.42439453635, 10005.499725013866, 10184.134348580157, 10244.692659220234, 10422.843657344994, 10467.214958878267, 10568.365898046142, 10674.199435042558, 10941.781164376827, 7598.582077985764, 7705.460617756703, 7747.0, 7765.53406795594, 7793.1427542969095, 9411.717648470283, 9713.562889670124, 10196.082352588302, 10267.383956962607, 10298.279120461795], "value": 8211.531012759198, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1309.1425116548653, 1413.6041908265686, 1469.1552357394498, 1559.2224863655435, 1767.0811178187334, 6856.0, 7601.239876012396, 7871.252231038042, 7876.606169691507, 7894.92105078949, 7544.622768861563, 7711.961440192806, 7758.262965018328, 7762.4178186635945, 7774.2614451627005, 1886.443499167742, 2137.0, 2186.0709198590575, 2211.159759291467, 2219.7669244729314, 2260.536589999046, 2278.293728944024, 2278.384836094262, 2281.669157972093, 2288.794008539231, 2182.5416662500893, 2230.5984922713906, 2231.141010710872, 2233.597952368573, 2234.575430668176, 1860.6650802855481, 2172.750133734617, 2261.570301642683, 2264.784845439681, 2268.206127855254, 2192.901319440629, 2198.395441253668, 2214.092222188895, 2217.6562632791943, 2244.6745221942892, 7704.46068775186, 7775.688972441096, 7778.611069446505, 7791.22087791222, 7796.0, 4523.796429160696, 4719.669623126382, 4726.409198850144, 4737.50256223095, 4759.048190361941, 2997.640283166034, 3062.2803641144314, 3083.275430273884, 3170.5402716605963, 3200.9519857202163, 1033.9431331276776, 1056.6513050693252, 1064.2284343850724, 1066.1790421375574, 1084.7559299157706, 10344.63793767222, 10610.787784244349, 10647.14822814173, 10674.306170098997, 10678.092362149227, 4223.493180818322, 4294.248506511348, 4382.890427739332, 4412.227860124465, 4420.226460369422, 9247.167754902091, 9255.861162082574, 9274.582643781046, 9282.582283797245, 9285.117913798178, 4183.477065366829, 4690.859274221779, 4697.248440249612, 4698.624110071186, 4714.834980775657, 4120.546739858613, 4158.438610787565, 4214.262504061777, 4221.092465120014, 4221.535631080578, 3695.6304369562827, 3741.5136032315627, 3807.3717836556657, 3838.673712734393, 3881.514810648669, 1221.2123180548497, 1227.742174143422, 1243.570968016033, 1248.4007676315239, 1258.4148371007343, 785.5051317669946, 850.6639877248452, 894.9931327256836, 895.1719659315238, 909.60432211988, 5474.452554744494, 5654.00591698294, 5675.3757086720425, 5774.307083150049, 5842.444967728059, 933.9719808405758, 937.7915010151132, 965.2133511188359, 969.9369540979814, 1006.4414250091123, 3700.648438398348, 3861.517310336208, 3867.7872717000837, 3880.2821478026653, 3971.0866500705, 9157.130072643089, 9367.391119577342, 9411.294152938557, 9458.196053335543, 9541.570629321559, 9346.766330841783, 9394.812103757886, 9396.859047114298, 9404.200642945427, 9450.810983780424, 7131.821704457327, 7236.819079522948, 7258.927410725931, 7291.125064992235, 7333.1200255969625, 5439.102548079681, 5535.0, 5575.8884822304135, 5609.663420194638, 5746.42535746422, 8700.303975681803, 8796.428232164888, 8838.0, 8953.776155596162, 8975.102489750972, 8598.054214036576, 8891.644334226818, 8983.595738191667, 9014.323925705467, 9114.544272786201, 6412.743490260337, 7194.820129496595, 7299.635018249172, 7428.182899880901, 7463.888041679271, 7530.623468826647, 7545.320921117126, 7598.164201937672, 7606.581638009962, 7611.923880761122, 6512.511561632802, 6738.326167383222, 6747.763828265987, 6872.140982377203, 6885.1049363582415, 6692.59844409337, 6701.53089283765, 6701.932980670131, 6735.73057077731, 6852.383285504328, 6199.132121503083, 6582.275949645631, 6628.5691430056895, 6672.165979252593, 6679.298673639392, 4579.404677391918, 4672.18236808564, 4751.144793937125, 4763.118823017753, 4800.615950724004, 4730.077634861169, 4748.976255118702, 4816.927746083741, 4836.854894353175, 4851.587615052619], "value": 4244.619790164373, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.24020830423586, 319.7633751024242, 321.24667654350554, 326.63253839430627, 331.71638249296836, 5036.496350364966, 5102.948970510299, 5104.38747350318, 5120.590352771778, 5130.769115389807, 4998.2752500887345, 5022.397312322517, 5041.243813427987, 5050.974745126269, 5060.190369540875, 3769.3215221260093, 3863.729538932276, 3938.172983673432, 3971.424143499191, 3991.7068418554663, 3971.4042893565907, 3989.620986006339, 4005.0988527581208, 4005.4192142139373, 4013.8595149169787, 3779.9622003779887, 3952.881413557598, 3962.4254483099935, 3974.9205015899665, 3983.103801644636, 3856.46009558662, 3920.7059470539825, 3939.6014414882875, 3948.0654479304935, 3953.5453422856453, 3510.4032314506594, 3529.611742708326, 3534.7525673202886, 3535.6034366425374, 3543.114221444639, 4825.324454576327, 4827.686200396963, 4842.564169224752, 4852.514748525155, 4863.221884498464, 4338.522762496123, 4553.658475614342, 4592.5177856324935, 4600.470945841238, 4611.930821037688, 5292.841214763564, 5293.788248470057, 5301.204819277139, 5308.787648494055, 5323.946760532383, 3729.4219395993664, 3891.3384724596604, 3896.5129358830145, 3896.7272290939645, 3900.1224724437056, 5508.08071721988, 5584.497395234408, 5584.972075139639, 5595.8880822383735, 5604.635698679532, 3955.3869150281753, 3974.28462876685, 3981.9402708959387, 3987.7806720630642, 3991.5808840071954, 4060.4315395844606, 4063.2482990646827, 4072.450219220367, 4072.9185416291507, 4088.693347998912, 4431.224535706238, 4572.954270457253, 4580.8163326487775, 4586.922073312769, 4591.816327346935, 5336.1462166054025, 5341.501316637531, 5345.305110335709, 5346.625736198506, 5351.143816989263, 1399.5871217990716, 1412.4773833681604, 1414.618053125671, 1421.3177674716194, 1427.4226979188056, 967.2213867836459, 977.2816979520047, 978.1832170137873, 984.0602224875227, 991.2020823237219, 4717.103750287434, 4719.3628860103445, 4736.573708366263, 4743.905121897612, 4745.952540474551, 5504.504594586507, 5515.889682206413, 5519.0, 5530.944690553043, 5532.75102620383, 4631.62946964242, 4725.291206319011, 4730.2431610942085, 4731.7634118293945, 4733.644976626767, 2920.985395073011, 2921.5033444314518, 2924.824510529375, 2934.618499595039, 2935.544990526472, 5189.792408303626, 5211.8175863845345, 5213.973930130325, 5214.296070030573, 5223.9477605223465, 5410.48600382963, 5638.210650508932, 5686.857828554319, 5695.60130790849, 5710.143478478261, 5219.321488206509, 5232.633715639869, 5240.71176085319, 5244.108501554745, 5253.658512196695, 5352.601098302528, 5544.3346798384455, 5550.389457159628, 5555.333359996826, 5584.441555844383, 5428.538574221236, 5431.266778984945, 5433.266509021231, 5461.426550212171, 5471.097268950579, 5234.555062819551, 5236.5548928339995, 5237.947620523746, 5239.816606418757, 5249.396319423163, 3688.170161713593, 3891.747036442622, 3919.7844118573753, 3924.136689928211, 3925.9018524535973, 5237.371515418175, 5358.606762241768, 5482.23248745184, 5492.5605951524585, 5496.203050557727, 5327.653702509325, 5334.306540149756, 5340.225667278145, 5342.252084708066, 5349.411564727799, 5335.73321333924, 5352.116900711495, 5354.759035843318, 5370.066775960573, 5374.596905232045, 5155.922661160011, 5206.245094461357, 5279.52484276417, 5284.180951952453, 5312.840614781563, 5367.35591728995, 5379.139337706105, 5383.7308134593895, 5389.083855744611, 5401.189821526802, 5213.739313034409, 5214.32213812202, 5230.503102205284, 5241.663375839136, 5243.213517972335], "value": 4051.717319204202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.7480394459964, 720.6288761287934, 733.3619750816787, 737.3695490355746, 744.9106107267127, 11107.777844443106, 12183.695407614814, 12567.183133096343, 12597.181183223083, 12644.620661380173, 13070.934645326784, 13108.147970381919, 13118.278494682812, 13171.078024538287, 13184.0, 640.3180612647539, 814.3566582399897, 820.3683163963744, 821.0434843407423, 821.6261600971574, 650.2879347114925, 655.4821690864212, 655.5607742812304, 778.649607676545, 808.5552945879772, 843.3253397282181, 845.6659619450344, 848.8387206430789, 848.893888263967, 850.0479463001416, 836.7908022994252, 840.3025488844306, 840.4075127035455, 840.4327079221562, 840.7393707950524, 490.25970784115884, 597.2623809595146, 609.8780243951228, 611.034565386688, 611.6605284067341, 11828.88171118295, 11900.702482437922, 11936.761264774656, 11963.102767292488, 11967.1622986391, 11366.659000230007, 12088.879111208864, 12175.634730958085, 12187.146899717023, 12364.814527782091, 9941.75145621358, 9951.452670103141, 10015.849762253572, 10049.196064314838, 10389.532471038821, 3268.4280250956226, 3294.4399452093203, 3307.834608269577, 3310.3875782980226, 3350.6816852398983, 47356.763216183695, 47395.0, 47824.04351912977, 47849.5215047852, 47993.5200647996, 9809.11717945374, 9863.0, 9901.455419951972, 9930.657387846402, 10061.346012509164, 15884.52346429609, 17132.48602541901, 17195.656086878193, 17231.913840430716, 17272.481825545256, 6767.221769496472, 6880.2431732509385, 6895.448364130857, 6947.4789390795895, 7033.613151276627, 3766.642168993996, 3926.2540117377607, 3994.6205110514456, 4008.6392224699334, 4009.2983727848095, 2871.239121632769, 2969.1834745445176, 2971.8216906985217, 2980.821150730963, 2986.134021133847, 527.8047122564676, 529.9629025968222, 536.8174820561028, 540.924270602116, 541.1368866657675, 440.7597859166762, 491.9262110683355, 520.3287758791192, 545.6862901298466, 546.7594258526316, 7336.96331518339, 7509.7371591994015, 7688.115866675292, 7812.765617031499, 7812.921870781333, 526.5497999210696, 537.1459379586477, 628.5819929746758, 636.748484348689, 638.2659941067809, 3656.926861462756, 3859.305325041463, 3889.8249578769023, 3895.3334762386266, 3954.6045395460224, 44708.0, 46030.0, 46100.7694961523, 53582.0, 53735.92528149415, 39345.40981885274, 39509.80245098756, 39642.80178599089, 44117.0, 44129.77935110304, 38750.0, 39439.0, 39946.600533994286, 40036.19927601432, 40433.1913361737, 7575.0, 7592.582407967615, 7661.502002369828, 7751.263629955145, 7815.941099560922, 28584.42831143324, 28635.14094577166, 28719.582390536732, 28806.567901481074, 29596.408071838014, 35553.1111722209, 37271.81364093162, 37278.8136059318, 37689.0, 38013.0, 9595.856062159213, 9600.847512165528, 9744.269179811685, 9775.902240977499, 9806.950965245129, 10549.578016879546, 10910.454477276264, 10952.809438112568, 11001.17491188148, 11068.28056176346, 10814.35113893169, 10985.890141098487, 11030.779384412428, 11218.55125794959, 11242.606508772154, 10733.677989660322, 10965.83551246716, 11462.312261264351, 11463.140264480364, 11481.36852473122, 10005.849912251177, 10464.058234758908, 10576.629817956335, 10964.780704385708, 10992.670219893416, 8903.554822258991, 8916.86624700617, 9062.410943288665, 9104.90895091067, 9412.576434060347, 9239.907600924174, 9312.860307095263, 9432.764180895532, 9445.905540944503, 9451.149396554343], "value": 5804.3733604662, "unit": "score"}], "name": "dromaeo_css", "value": 6257.165665354691, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 107.0, 113.0, 112.0, 113.0, 102.0, 111.0, 113.0, 111.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 154.0, 182.0, 132.0, 158.0, 156.0, 136.0, 183.0, 132.0], "value": 152.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 158.0, 162.0, 160.0, 160.0, 163.0, 160.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 73.0, 111.0, 110.0, 75.0, 74.0, 73.0, 121.0, 110.0, 74.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 144.0, 93.0, 93.0, 93.0, 147.0, 93.0, 93.0, 141.0], "value": 108.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 66.0, 65.0, 65.0, 80.0, 63.0, 74.0], "value": 67.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 66.0, 65.0, 67.0, 65.0, 65.0, 65.0], "value": 65.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 83.0, 85.0, 82.0, 86.0, 84.0, 84.0, 84.0, 84.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 137.0, 135.0, 137.0, 133.0, 137.0, 136.0, 146.0, 177.0, 147.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 171.0, 175.0, 174.0, 172.0, 172.0, 171.0, 170.0, 169.0, 171.0], "value": 171.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 69.0, 73.0, 76.0, 74.0, 70.0, 70.0, 70.0, 71.0], "value": 72.2, "unit": "score"}], "name": "kraken", "value": 1583.1, "alertThreshold": 2.0}]} 23:07:52 INFO - Return code: 0 23:07:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:07:53 ERROR - # TBPL SUCCESS # 23:07:53 INFO - Running post-action listener: _resource_record_post_action 23:07:53 INFO - Running post-run listener: _resource_record_post_run 23:07:54 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276025344; Read time: 8; Write time: 312888 23:07:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 438272; Read time: 0; Write time: 36 23:07:54 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275587072; Read time: 8; Write time: 312852 23:07:54 INFO - Running post-run listener: _upload_blobber_files 23:07:54 INFO - Blob upload gear active. 23:07:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:07:54 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:07:54 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:07:54 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:07:54 INFO - (blobuploader) - INFO - Open directory for files ... 23:07:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:07:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:55 INFO - (blobuploader) - INFO - Done attempting. 23:07:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:07:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:07:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:07:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:07:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:07:55 INFO - (blobuploader) - INFO - Done attempting. 23:07:55 INFO - (blobuploader) - INFO - Iteration through files over. 23:07:55 INFO - Return code: 0 23:07:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:07:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:07:55 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538913953229ac921f15ce6a17c492d0ba70634d6644d6d6ffdda7564ad30a54b4e22dd09ab0e32bc20068006078f3b9fa199b9f49daf6d008b3c45be7bb5b1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/257fdcfd7614575c08f142918ddd4fb01ee176e413153267a24c499bbbce4907de7387643ff8651a06c0b4170b7695198869161ccf440037a1800c142b91044e"} 23:07:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:07:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:07:55 INFO - Contents: 23:07:55 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/538913953229ac921f15ce6a17c492d0ba70634d6644d6d6ffdda7564ad30a54b4e22dd09ab0e32bc20068006078f3b9fa199b9f49daf6d008b3c45be7bb5b1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/257fdcfd7614575c08f142918ddd4fb01ee176e413153267a24c499bbbce4907de7387643ff8651a06c0b4170b7695198869161ccf440037a1800c142b91044e"} 23:07:55 INFO - Running post-run listener: copy_logs_to_upload_dir 23:07:55 INFO - Copying logs to upload dir... 23:07:55 INFO - mkdir: /builds/slave/test/build/upload/logs 23:07:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.922198 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-04-14 23:07:56.002275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 23:07:56.005439) ========= 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-1460698981.188259-1282741405 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/538913953229ac921f15ce6a17c492d0ba70634d6644d6d6ffdda7564ad30a54b4e22dd09ab0e32bc20068006078f3b9fa199b9f49daf6d008b3c45be7bb5b1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/257fdcfd7614575c08f142918ddd4fb01ee176e413153267a24c499bbbce4907de7387643ff8651a06c0b4170b7695198869161ccf440037a1800c142b91044e"} build_url:https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011185 build_url: 'https://queue.taskcluster.net/v1/task/JLgLNlRHTaSCH9FEvMromQ/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/538913953229ac921f15ce6a17c492d0ba70634d6644d6d6ffdda7564ad30a54b4e22dd09ab0e32bc20068006078f3b9fa199b9f49daf6d008b3c45be7bb5b1b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/257fdcfd7614575c08f142918ddd4fb01ee176e413153267a24c499bbbce4907de7387643ff8651a06c0b4170b7695198869161ccf440037a1800c142b91044e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-14 23:07:56.029964) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 23:07:56.030303) ========= 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-1460698981.188259-1282741405 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004479 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-14 23:07:56.114067) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 23:07:56.114428) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-14 23:07:56.114725) ========= ========= Total master_lag: 0.17 =========