builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-058 starttime: 1461825513.04 results: success (0) buildid: 20160427173008 builduid: e466efc4a24a43d09255860c1cb08dee revision: d14d6f68201e667c9a73f9dc1917b5a9505f845a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.044725) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.045190) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.045475) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.096273) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.096551) ========= 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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-27 23:38:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 24.7M=0s 2016-04-27 23:38:33 (24.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.124757 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.239693) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.239988) ========= 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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.289790) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.290160) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d14d6f68201e667c9a73f9dc1917b5a9505f845a --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 d14d6f68201e667c9a73f9dc1917b5a9505f845a --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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-27 23:38:33,878 truncating revision to first 12 chars 2016-04-27 23:38:33,878 Setting DEBUG logging. 2016-04-27 23:38:33,878 attempt 1/10 2016-04-27 23:38:33,878 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d14d6f68201e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 23:38:34,150 unpacking tar archive at: fx-team-d14d6f68201e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.544311 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.847259) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.847540) ========= script_repo_revision: d14d6f68201e667c9a73f9dc1917b5a9505f845a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.847907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.848195) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 23:38:33.860386) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 8 secs) (at 2016-04-27 23:38:33.860652) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:38:34 INFO - MultiFileLogger online at 20160427 23:38:34 in /builds/slave/test 23:38:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:38:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:38:34 INFO - {'append_to_log': False, 23:38:34 INFO - 'base_work_dir': '/builds/slave/test', 23:38:34 INFO - 'blob_upload_branch': 'Fx-Team', 23:38:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:38:34 INFO - 'branch': 'Fx-Team', 23:38:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:38:34 INFO - 'config_files': ('talos/linux_config.py',), 23:38:34 INFO - 'default_actions': ('clobber', 23:38:34 INFO - 'read-buildbot-config', 23:38:34 INFO - 'download-and-extract', 23:38:34 INFO - 'populate-webroot', 23:38:34 INFO - 'create-virtualenv', 23:38:34 INFO - 'install', 23:38:34 INFO - 'run-tests'), 23:38:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:38:34 INFO - 'download_minidump_stackwalk': True, 23:38:34 INFO - 'download_symbols': 'ondemand', 23:38:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:38:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:38:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:38:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:38:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:38:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:38:34 INFO - 'installer_path': 'installer.exe', 23:38:34 INFO - 'log_level': 'info', 23:38:34 INFO - 'log_name': 'talos', 23:38:34 INFO - 'log_to_console': True, 23:38:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:38:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:38:34 INFO - 'opt_config_files': (), 23:38:34 INFO - 'pip_index': False, 23:38:34 INFO - 'sps_profile': False, 23:38:34 INFO - 'sps_profile_interval': 0, 23:38:34 INFO - 'suite': 'dromaeojs', 23:38:34 INFO - 'system_bits': '32', 23:38:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:38:34 INFO - 'title': 'talos-linux64-ix-058', 23:38:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:38:34 INFO - 'use_talos_json': True, 23:38:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:38:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:38:34 INFO - 'work_dir': 'build'} 23:38:34 INFO - ##### 23:38:34 INFO - ##### Running clobber step. 23:38:34 INFO - ##### 23:38:34 INFO - Running pre-action listener: _resource_record_pre_action 23:38:34 INFO - Running main action method: clobber 23:38:34 INFO - rmtree: /builds/slave/test/build 23:38:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:38:35 INFO - Running post-action listener: _resource_record_post_action 23:38:35 INFO - ##### 23:38:35 INFO - ##### Running read-buildbot-config step. 23:38:35 INFO - ##### 23:38:35 INFO - Running pre-action listener: _resource_record_pre_action 23:38:35 INFO - Running main action method: read_buildbot_config 23:38:35 INFO - Using buildbot properties: 23:38:35 INFO - { 23:38:35 INFO - "project": "", 23:38:35 INFO - "product": "firefox", 23:38:35 INFO - "script_repo_revision": "production", 23:38:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 23:38:35 INFO - "repository": "", 23:38:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 23:38:35 INFO - "buildid": "20160427173008", 23:38:35 INFO - "pgo_build": "True", 23:38:35 INFO - "basedir": "/builds/slave/test", 23:38:35 INFO - "buildnumber": 617, 23:38:35 INFO - "slavename": "talos-linux64-ix-058", 23:38:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 23:38:35 INFO - "platform": "ubuntu64_hw", 23:38:35 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:38:35 INFO - "branch": "fx-team", 23:38:35 INFO - "repo_path": "integration/fx-team", 23:38:35 INFO - "revision": "d14d6f68201e667c9a73f9dc1917b5a9505f845a", 23:38:35 INFO - "stage_platform": "linux64-pgo", 23:38:35 INFO - "builduid": "e466efc4a24a43d09255860c1cb08dee", 23:38:35 INFO - "slavebuilddir": "test" 23:38:35 INFO - } 23:38:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 23:38:35 INFO - Running post-action listener: _resource_record_post_action 23:38:35 INFO - ##### 23:38:35 INFO - ##### Running download-and-extract step. 23:38:35 INFO - ##### 23:38:35 INFO - Running pre-action listener: _resource_record_pre_action 23:38:35 INFO - Running main action method: download_and_extract 23:38:35 INFO - mkdir: /builds/slave/test/build/tests 23:38:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:35 INFO - https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:38:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:38:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:38:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:38:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 23:38:46 INFO - Downloaded 1361 bytes. 23:38:46 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 23:38:46 INFO - Using the following test package requirements: 23:38:46 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:38:46 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:38:46 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:38:46 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'jsshell-linux-x86_64.zip'], 23:38:46 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:38:46 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 23:38:46 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:38:46 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:38:46 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:38:46 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 23:38:46 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:38:46 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:38:46 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')]} 23:38:46 INFO - https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:38:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:38:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:38:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:38:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:38:59 INFO - Downloaded 23866029 bytes. 23:38:59 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:38:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:39:00 INFO - Return code: 0 23:39:00 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 23:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:00 INFO - https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:39:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:39:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:39:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 23:39:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 23:39:02 INFO - Downloaded 23866029 bytes. 23:39:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 23:39:03 INFO - Return code: 0 23:39:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:03 INFO - https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:39:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 23:39:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 23:39:04 INFO - Downloaded 10840145 bytes. 23:39:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:39:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 23:39:05 INFO - Return code: 0 23:39:05 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')]} 23:39:05 INFO - https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:39:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:39:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:39:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:39:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 23:39:09 INFO - Downloaded 58368924 bytes. 23:39:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:39:09 INFO - mkdir: /builds/slave/test/properties 23:39:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:39:09 INFO - Writing to file /builds/slave/test/properties/build_url 23:39:09 INFO - Contents: 23:39:09 INFO - build_url:https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 23:39:10 INFO - Running post-action listener: _resource_record_post_action 23:39:10 INFO - Running post-action listener: set_extra_try_arguments 23:39:10 INFO - ##### 23:39:10 INFO - ##### Running populate-webroot step. 23:39:10 INFO - ##### 23:39:10 INFO - Running pre-action listener: _resource_record_pre_action 23:39:10 INFO - Running main action method: populate_webroot 23:39:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:39:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:39:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:39:10 INFO - '--tppagecycles', 23:39:10 INFO - '7'], 23:39:10 INFO - 'tests': ['tsvgm']}}, 23:39:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:39:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:39:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:39:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:39:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:39:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['damp', 'tps']}, 23:39:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'tests': ['damp', 'tps']}, 23:39:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['dromaeo_dom']}, 23:39:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:39:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'other-e10s': {'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['a11yr', 23:39:10 INFO - 'ts_paint', 23:39:10 INFO - 'tpaint', 23:39:10 INFO - 'sessionrestore', 23:39:10 INFO - 'sessionrestore_no_auto_restore', 23:39:10 INFO - 'tabpaint']}, 23:39:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['tsvgx', 23:39:10 INFO - 'tsvgr_opacity', 23:39:10 INFO - 'tart', 23:39:10 INFO - 'tscrollx', 23:39:10 INFO - 'cart']}, 23:39:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:39:10 INFO - 'tsvgr_opacity', 23:39:10 INFO - 'tart', 23:39:10 INFO - 'tscrollx', 23:39:10 INFO - 'cart']}, 23:39:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'talos_options': ['--disable-e10s'], 23:39:10 INFO - 'tests': ['tp5o']}, 23:39:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'tests': ['tp5o']}, 23:39:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'talos_options': ['--disable-e10s', 23:39:10 INFO - '--xperf_path', 23:39:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:10 INFO - 'tests': ['tp5n']}, 23:39:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:39:10 INFO - 'talos_options': ['--xperf_path', 23:39:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:39:10 INFO - 'tests': ['tp5n']}}, 23:39:10 INFO - 'talos.zip': {'path': '', 23:39:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:39:10 INFO - Running post-action listener: _resource_record_post_action 23:39:10 INFO - ##### 23:39:10 INFO - ##### Running create-virtualenv step. 23:39:10 INFO - ##### 23:39:10 INFO - Running pre-action listener: _resource_record_pre_action 23:39:10 INFO - Running main action method: create_virtualenv 23:39:10 INFO - Creating virtualenv /builds/slave/test/build/venv 23:39:10 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 23:39:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:39:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:39:10 INFO - Using real prefix '/usr' 23:39:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:39:10 INFO - Installing distribute.............................................................................................................................................................................................done. 23:39:12 INFO - Installing pip.................done. 23:39:12 INFO - Return code: 0 23:39:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:39:12 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')]} 23:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:12 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')]} 23:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:12 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:12 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 23:39:12 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 23:39:12 INFO - Using env: {'DISPLAY': ':0', 23:39:12 INFO - 'HOME': '/home/cltbld', 23:39:12 INFO - 'LANG': 'en_US.UTF-8', 23:39:12 INFO - 'LANGUAGE': 'en_US:en', 23:39:12 INFO - 'LOGNAME': 'cltbld', 23:39:12 INFO - 'MAIL': '/var/mail/cltbld', 23:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:12 INFO - 'MOZ_NO_REMOTE': '1', 23:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:12 INFO - 'NO_EM_RESTART': '1', 23:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:12 INFO - 'PWD': '/builds/slave/test', 23:39:12 INFO - 'SHELL': '/bin/bash', 23:39:12 INFO - 'SHLVL': '1', 23:39:12 INFO - 'TERM': 'linux', 23:39:12 INFO - 'TMOUT': '86400', 23:39:12 INFO - 'USER': 'cltbld', 23:39:12 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:12 INFO - '_': '/tools/buildbot/bin/python'} 23:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:12 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 23:39:12 INFO - Cleaning up... 23:39:13 INFO - Return code: 0 23:39:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 23:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:13 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:13 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 23:39:13 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 23:39:13 INFO - Using env: {'DISPLAY': ':0', 23:39:13 INFO - 'HOME': '/home/cltbld', 23:39:13 INFO - 'LANG': 'en_US.UTF-8', 23:39:13 INFO - 'LANGUAGE': 'en_US:en', 23:39:13 INFO - 'LOGNAME': 'cltbld', 23:39:13 INFO - 'MAIL': '/var/mail/cltbld', 23:39:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:13 INFO - 'MOZ_NO_REMOTE': '1', 23:39:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:13 INFO - 'NO_EM_RESTART': '1', 23:39:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:13 INFO - 'PWD': '/builds/slave/test', 23:39:13 INFO - 'SHELL': '/bin/bash', 23:39:13 INFO - 'SHLVL': '1', 23:39:13 INFO - 'TERM': 'linux', 23:39:13 INFO - 'TMOUT': '86400', 23:39:13 INFO - 'USER': 'cltbld', 23:39:13 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:13 INFO - '_': '/tools/buildbot/bin/python'} 23:39:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:13 INFO - Downloading/unpacking psutil>=0.7.1 23:39:13 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 23:39:13 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 23:39:13 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 23:39:13 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 23:39:13 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 23:39:13 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 23:39:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:39:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:39:15 INFO - Installing collected packages: psutil 23:39:15 INFO - Running setup.py install for psutil 23:39:15 INFO - building 'psutil._psutil_linux' extension 23:39:15 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 23:39:15 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 23:39:15 INFO - building 'psutil._psutil_posix' extension 23:39:15 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 23:39:15 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 23:39:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:39:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:39:15 INFO - Successfully installed psutil 23:39:15 INFO - Cleaning up... 23:39:15 INFO - Return code: 0 23:39:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 23:39: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')]} 23:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39: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')]} 23:39:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 23:39:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 23:39:15 INFO - Using env: {'DISPLAY': ':0', 23:39:15 INFO - 'HOME': '/home/cltbld', 23:39:15 INFO - 'LANG': 'en_US.UTF-8', 23:39:15 INFO - 'LANGUAGE': 'en_US:en', 23:39:15 INFO - 'LOGNAME': 'cltbld', 23:39:15 INFO - 'MAIL': '/var/mail/cltbld', 23:39:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:15 INFO - 'MOZ_NO_REMOTE': '1', 23:39:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:15 INFO - 'NO_EM_RESTART': '1', 23:39:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:15 INFO - 'PWD': '/builds/slave/test', 23:39:15 INFO - 'SHELL': '/bin/bash', 23:39:15 INFO - 'SHLVL': '1', 23:39:15 INFO - 'TERM': 'linux', 23:39:15 INFO - 'TMOUT': '86400', 23:39:15 INFO - 'USER': 'cltbld', 23:39:15 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:15 INFO - '_': '/tools/buildbot/bin/python'} 23:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:15 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 23:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 23:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 23:39:17 INFO - Installing collected packages: mozsystemmonitor 23:39:17 INFO - Running setup.py install for mozsystemmonitor 23:39:17 INFO - Successfully installed mozsystemmonitor 23:39:17 INFO - Cleaning up... 23:39:18 INFO - Return code: 0 23:39:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:39: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')]} 23:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39: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')]} 23:39:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:18 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:18 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 23:39:18 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 23:39:18 INFO - Using env: {'DISPLAY': ':0', 23:39:18 INFO - 'HOME': '/home/cltbld', 23:39:18 INFO - 'LANG': 'en_US.UTF-8', 23:39:18 INFO - 'LANGUAGE': 'en_US:en', 23:39:18 INFO - 'LOGNAME': 'cltbld', 23:39:18 INFO - 'MAIL': '/var/mail/cltbld', 23:39:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:18 INFO - 'MOZ_NO_REMOTE': '1', 23:39:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:18 INFO - 'NO_EM_RESTART': '1', 23:39:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:18 INFO - 'PWD': '/builds/slave/test', 23:39:18 INFO - 'SHELL': '/bin/bash', 23:39:18 INFO - 'SHLVL': '1', 23:39:18 INFO - 'TERM': 'linux', 23:39:18 INFO - 'TMOUT': '86400', 23:39:18 INFO - 'USER': 'cltbld', 23:39:18 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:18 INFO - '_': '/tools/buildbot/bin/python'} 23:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 23:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 23:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:39:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:39:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:39:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:39:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:39:20 INFO - Downloading docopt-0.6.1.tar.gz 23:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:39:20 INFO - Installing collected packages: blobuploader, requests, docopt 23:39:20 INFO - Running setup.py install for blobuploader 23:39:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:39:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:39:20 INFO - Running setup.py install for requests 23:39:21 INFO - Running setup.py install for docopt 23:39:21 INFO - Successfully installed blobuploader requests docopt 23:39:21 INFO - Cleaning up... 23:39:21 INFO - Return code: 0 23:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:21 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')]} 23:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:21 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')]} 23:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:21 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:21 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 23:39:21 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 23:39:21 INFO - Using env: {'DISPLAY': ':0', 23:39:21 INFO - 'HOME': '/home/cltbld', 23:39:21 INFO - 'LANG': 'en_US.UTF-8', 23:39:21 INFO - 'LANGUAGE': 'en_US:en', 23:39:21 INFO - 'LOGNAME': 'cltbld', 23:39:21 INFO - 'MAIL': '/var/mail/cltbld', 23:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:21 INFO - 'MOZ_NO_REMOTE': '1', 23:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:21 INFO - 'NO_EM_RESTART': '1', 23:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:21 INFO - 'PWD': '/builds/slave/test', 23:39:21 INFO - 'SHELL': '/bin/bash', 23:39:21 INFO - 'SHLVL': '1', 23:39:21 INFO - 'TERM': 'linux', 23:39:21 INFO - 'TMOUT': '86400', 23:39:21 INFO - 'USER': 'cltbld', 23:39:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:21 INFO - '_': '/tools/buildbot/bin/python'} 23:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:39:21 INFO - Running setup.py (path:/tmp/pip-FQKPTh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:39:21 INFO - Running setup.py (path:/tmp/pip-ToTTfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:39:21 INFO - Running setup.py (path:/tmp/pip-axcFca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:39:21 INFO - Running setup.py (path:/tmp/pip-DixaDo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:39:21 INFO - Running setup.py (path:/tmp/pip-m9LGsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:39:22 INFO - Running setup.py (path:/tmp/pip-rb15Pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:39:22 INFO - Running setup.py (path:/tmp/pip-ObozCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:39:22 INFO - Running setup.py (path:/tmp/pip-xkUMQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:39:22 INFO - Running setup.py (path:/tmp/pip-evi0lv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:39:22 INFO - Running setup.py (path:/tmp/pip-gw3vYp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:39:22 INFO - Running setup.py (path:/tmp/pip-2Y0S_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:39:22 INFO - Running setup.py (path:/tmp/pip-SDg9SA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:39:22 INFO - Running setup.py (path:/tmp/pip-YnOOQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:39:22 INFO - Running setup.py (path:/tmp/pip-OYQ6Kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:22 INFO - Running setup.py (path:/tmp/pip-dQz9Jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:39:22 INFO - Running setup.py (path:/tmp/pip-AQzDBb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:39:22 INFO - Running setup.py (path:/tmp/pip-dSNfKn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:39:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:39:22 INFO - Running setup.py install for manifestparser 23:39:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:39:22 INFO - Running setup.py install for mozcrash 23:39:23 INFO - Running setup.py install for mozdebug 23:39:23 INFO - Running setup.py install for mozdevice 23:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for mozfile 23:39:23 INFO - Running setup.py install for mozhttpd 23:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for mozinfo 23:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for mozInstall 23:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for mozleak 23:39:23 INFO - Running setup.py install for mozlog 23:39:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for moznetwork 23:39:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:39:23 INFO - Running setup.py install for mozprocess 23:39:24 INFO - Running setup.py install for mozprofile 23:39:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:39:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:39:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:39:24 INFO - Running setup.py install for mozrunner 23:39:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:39:24 INFO - Running setup.py install for mozscreenshot 23:39:24 INFO - Running setup.py install for moztest 23:39:24 INFO - Running setup.py install for mozversion 23:39:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:39:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:39:24 INFO - Cleaning up... 23:39:24 INFO - Return code: 0 23:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:24 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')]} 23:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:24 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')]} 23:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:24 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:24 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 23:39:24 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 23:39:24 INFO - Using env: {'DISPLAY': ':0', 23:39:24 INFO - 'HOME': '/home/cltbld', 23:39:24 INFO - 'LANG': 'en_US.UTF-8', 23:39:24 INFO - 'LANGUAGE': 'en_US:en', 23:39:24 INFO - 'LOGNAME': 'cltbld', 23:39:24 INFO - 'MAIL': '/var/mail/cltbld', 23:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:24 INFO - 'MOZ_NO_REMOTE': '1', 23:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:24 INFO - 'NO_EM_RESTART': '1', 23:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:24 INFO - 'PWD': '/builds/slave/test', 23:39:24 INFO - 'SHELL': '/bin/bash', 23:39:24 INFO - 'SHLVL': '1', 23:39:24 INFO - 'TERM': 'linux', 23:39:24 INFO - 'TMOUT': '86400', 23:39:24 INFO - 'USER': 'cltbld', 23:39:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:24 INFO - '_': '/tools/buildbot/bin/python'} 23:39:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:39:24 INFO - Running setup.py (path:/tmp/pip-rn9sIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:39:24 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)) 23:39:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:39:24 INFO - Running setup.py (path:/tmp/pip-25btVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:39:25 INFO - Running setup.py (path:/tmp/pip-VucO7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:39:25 INFO - Running setup.py (path:/tmp/pip-bEB8CB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:39:25 INFO - Running setup.py (path:/tmp/pip-WqYGJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:39:25 INFO - Running setup.py (path:/tmp/pip-H1IQYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:39:25 INFO - Running setup.py (path:/tmp/pip-4yzavQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:39:25 INFO - Running setup.py (path:/tmp/pip-3Iw7jD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:39:25 INFO - Running setup.py (path:/tmp/pip-caDacf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:39:25 INFO - Running setup.py (path:/tmp/pip-_rqoXR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:39:25 INFO - Running setup.py (path:/tmp/pip-1q60N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:39:25 INFO - Running setup.py (path:/tmp/pip-7uVvuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:39:25 INFO - Running setup.py (path:/tmp/pip-MVbpy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:39:25 INFO - Running setup.py (path:/tmp/pip-LO7t8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:25 INFO - Running setup.py (path:/tmp/pip-1Pd4jO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:39:25 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)) 23:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:39:25 INFO - Running setup.py (path:/tmp/pip-ahftWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:39:26 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)) 23:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:39:26 INFO - Running setup.py (path:/tmp/pip-pioTiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:39:26 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)) 23:39:26 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)) 23:39:26 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)) 23:39:26 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)) 23:39:26 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)) 23:39:26 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)) 23:39:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:39:26 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 23:39:26 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 23:39:26 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 23:39:26 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 23:39:26 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 23:39:26 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 23:39:27 INFO - Downloading blessings-1.6.tar.gz 23:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:39:28 INFO - Installing collected packages: blessings 23:39:28 INFO - Running setup.py install for blessings 23:39:28 INFO - Successfully installed blessings 23:39:28 INFO - Cleaning up... 23:39:28 INFO - Return code: 0 23:39:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:39:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:39:28 INFO - Reading from file tmpfile_stdout 23:39:28 INFO - Current package versions: 23:39:28 INFO - argparse == 1.2.1 23:39:28 INFO - blessings == 1.6 23:39:28 INFO - blobuploader == 1.2.4 23:39:28 INFO - docopt == 0.6.1 23:39:28 INFO - manifestparser == 1.1 23:39:28 INFO - mozInstall == 1.12 23:39:28 INFO - mozcrash == 0.17 23:39:28 INFO - mozdebug == 0.1 23:39:28 INFO - mozdevice == 0.48 23:39:28 INFO - mozfile == 1.2 23:39:28 INFO - mozhttpd == 0.7 23:39:28 INFO - mozinfo == 0.9 23:39:28 INFO - mozleak == 0.1 23:39:28 INFO - mozlog == 3.1 23:39:28 INFO - moznetwork == 0.27 23:39:28 INFO - mozprocess == 0.22 23:39:28 INFO - mozprofile == 0.28 23:39:28 INFO - mozrunner == 6.11 23:39:28 INFO - mozscreenshot == 0.1 23:39:28 INFO - mozsystemmonitor == 0.0 23:39:28 INFO - moztest == 0.7 23:39:28 INFO - mozversion == 1.4 23:39:28 INFO - psutil == 3.1.1 23:39:28 INFO - requests == 1.2.3 23:39:28 INFO - wsgiref == 0.1.2 23:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:28 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 23:39:28 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 23:39:28 INFO - Using env: {'DISPLAY': ':0', 23:39:28 INFO - 'HOME': '/home/cltbld', 23:39:28 INFO - 'LANG': 'en_US.UTF-8', 23:39:28 INFO - 'LANGUAGE': 'en_US:en', 23:39:28 INFO - 'LOGNAME': 'cltbld', 23:39:28 INFO - 'MAIL': '/var/mail/cltbld', 23:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:28 INFO - 'MOZ_NO_REMOTE': '1', 23:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:28 INFO - 'NO_EM_RESTART': '1', 23:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:28 INFO - 'PWD': '/builds/slave/test', 23:39:28 INFO - 'SHELL': '/bin/bash', 23:39:28 INFO - 'SHLVL': '1', 23:39:28 INFO - 'TERM': 'linux', 23:39:28 INFO - 'TMOUT': '86400', 23:39:28 INFO - 'USER': 'cltbld', 23:39:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:28 INFO - '_': '/tools/buildbot/bin/python'} 23:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 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)) 23:39:28 INFO - Cleaning up... 23:39:28 INFO - Return code: 0 23:39:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39:28 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 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39:28 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 23:39:28 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 23:39:28 INFO - Using env: {'DISPLAY': ':0', 23:39:28 INFO - 'HOME': '/home/cltbld', 23:39:28 INFO - 'LANG': 'en_US.UTF-8', 23:39:28 INFO - 'LANGUAGE': 'en_US:en', 23:39:28 INFO - 'LOGNAME': 'cltbld', 23:39:28 INFO - 'MAIL': '/var/mail/cltbld', 23:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:28 INFO - 'MOZ_NO_REMOTE': '1', 23:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:28 INFO - 'NO_EM_RESTART': '1', 23:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:28 INFO - 'PWD': '/builds/slave/test', 23:39:28 INFO - 'SHELL': '/bin/bash', 23:39:28 INFO - 'SHLVL': '1', 23:39:28 INFO - 'TERM': 'linux', 23:39:28 INFO - 'TMOUT': '86400', 23:39:28 INFO - 'USER': 'cltbld', 23:39:28 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:28 INFO - '_': '/tools/buildbot/bin/python'} 23:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:29 INFO - Downloading/unpacking jsonschema 23:39:29 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 23:39:29 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 23:39:29 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 23:39:29 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 23:39:29 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 23:39:29 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 23:39:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:39:30 INFO - Downloading/unpacking functools32 (from jsonschema) 23:39:30 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 23:39:30 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 23:39:30 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 23:39:30 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 23:39:30 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 23:39:30 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 23:39:31 INFO - Downloading functools32-3.2.3-2.tar.gz 23:39:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:39:31 INFO - warning: no files found matching '*.txt' 23:39:31 INFO - no previously-included directories found matching 'build' 23:39:31 INFO - no previously-included directories found matching 'dist' 23:39:31 INFO - no previously-included directories found matching '.git*' 23:39:31 INFO - Installing collected packages: jsonschema, functools32 23:39:31 INFO - Running setup.py install for functools32 23:39:31 INFO - warning: no files found matching '*.txt' 23:39:31 INFO - no previously-included directories found matching 'build' 23:39:31 INFO - no previously-included directories found matching 'dist' 23:39:31 INFO - no previously-included directories found matching '.git*' 23:39:31 INFO - Successfully installed jsonschema functools32 23:39:31 INFO - Cleaning up... 23:39:31 INFO - Return code: 0 23:39:31 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 23:39: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')]} 23:39:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:39:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39: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')]} 23:39:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:39:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:39: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f43fd54ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b988a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c639a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, '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': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', '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 23:39: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', 'flake8'] in /builds/slave/test/build 23:39: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 flake8 23:39:31 INFO - Using env: {'DISPLAY': ':0', 23:39:31 INFO - 'HOME': '/home/cltbld', 23:39:31 INFO - 'LANG': 'en_US.UTF-8', 23:39:31 INFO - 'LANGUAGE': 'en_US:en', 23:39:31 INFO - 'LOGNAME': 'cltbld', 23:39:31 INFO - 'MAIL': '/var/mail/cltbld', 23:39:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:31 INFO - 'MOZ_NO_REMOTE': '1', 23:39:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:31 INFO - 'NO_EM_RESTART': '1', 23:39:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:31 INFO - 'PWD': '/builds/slave/test', 23:39:31 INFO - 'SHELL': '/bin/bash', 23:39:31 INFO - 'SHLVL': '1', 23:39:31 INFO - 'TERM': 'linux', 23:39:31 INFO - 'TMOUT': '86400', 23:39:31 INFO - 'USER': 'cltbld', 23:39:31 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:31 INFO - '_': '/tools/buildbot/bin/python'} 23:39:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:39:31 INFO - Downloading/unpacking flake8 23:39:31 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 23:39:31 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 23:39:31 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 23:39:31 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 23:39:31 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 23:39:31 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 23:39:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 23:39:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 23:39:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:33 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 23:39:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 23:39:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:39:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:39:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:39:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:39:34 INFO - no previously-included directories found matching 'docs/_build' 23:39:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 23:39:34 INFO - Running setup.py install for pep8 23:39:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 23:39:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 23:39:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 23:39:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 23:39:34 INFO - no previously-included directories found matching 'docs/_build' 23:39:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 23:39:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 23:39:34 INFO - Cleaning up... 23:39:35 INFO - Return code: 0 23:39:35 INFO - Running post-action listener: _resource_record_post_action 23:39:35 INFO - Running post-action listener: _start_resource_monitoring 23:39:35 INFO - Starting resource monitoring. 23:39:35 INFO - ##### 23:39:35 INFO - ##### Running install step. 23:39:35 INFO - ##### 23:39:35 INFO - Running pre-action listener: _resource_record_pre_action 23:39:35 INFO - Running main action method: install 23:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:39:35 INFO - Reading from file tmpfile_stdout 23:39:35 INFO - Detecting whether we're running mozinstall >=1.0... 23:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:39:35 INFO - Reading from file tmpfile_stdout 23:39:35 INFO - Output received: 23:39:35 INFO - Usage: mozinstall [options] installer 23:39:35 INFO - Options: 23:39:35 INFO - -h, --help show this help message and exit 23:39:35 INFO - -d DEST, --destination=DEST 23:39:35 INFO - Directory to install application into. [default: 23:39:35 INFO - "/builds/slave/test"] 23:39:35 INFO - --app=APP Application being installed. [default: firefox] 23:39:35 INFO - mkdir: /builds/slave/test/build/application 23:39:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 23:39:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 23:39:51 INFO - Reading from file tmpfile_stdout 23:39:51 INFO - Output received: 23:39:51 INFO - /builds/slave/test/build/application/firefox/firefox 23:39:51 INFO - Running post-action listener: _resource_record_post_action 23:39:51 INFO - ##### 23:39:51 INFO - ##### Running run-tests step. 23:39:51 INFO - ##### 23:39:51 INFO - Running pre-action listener: _resource_record_pre_action 23:39:51 INFO - Running main action method: run_tests 23:39:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:39:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:39:51 INFO - Python 2.7.3 23:39:51 INFO - Return code: 0 23:39:51 INFO - grabbing minidump binary from tooltool 23:39:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:39:51 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 0x2cf2810>, '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 0x2cf3710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cf3ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:39:51 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 23:39:51 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 23:39:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:39:52 INFO - Return code: 0 23:39:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:39:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:39:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:39:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:39:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 23:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 23:39:52 INFO - Return code: 0 23:39:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:39:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 23:39:52 INFO - Using env: {'DISPLAY': ':0', 23:39:52 INFO - 'HOME': '/home/cltbld', 23:39:52 INFO - 'LANG': 'en_US.UTF-8', 23:39:52 INFO - 'LANGUAGE': 'en_US:en', 23:39:52 INFO - 'LOGNAME': 'cltbld', 23:39:52 INFO - 'MAIL': '/var/mail/cltbld', 23:39:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:39:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:39:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:39:52 INFO - 'MOZ_NO_REMOTE': '1', 23:39:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:39:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:39:52 INFO - 'NO_EM_RESTART': '1', 23:39:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:39:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:39:52 INFO - 'PWD': '/builds/slave/test', 23:39:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:39:52 INFO - 'SHELL': '/bin/bash', 23:39:52 INFO - 'SHLVL': '1', 23:39:52 INFO - 'TERM': 'linux', 23:39:52 INFO - 'TMOUT': '86400', 23:39:52 INFO - 'USER': 'cltbld', 23:39:52 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653', 23:39:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:39:52 INFO - '_': '/tools/buildbot/bin/python'} 23:39:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 23:39:53 INFO - mozversion application_buildid: 20160427173008 23:39:53 INFO - mozversion application_changeset: d14d6f68201e667c9a73f9dc1917b5a9505f845a 23:39:53 INFO - mozversion application_display_name: Nightly 23:39:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:39:53 INFO - mozversion application_name: Firefox 23:39:53 INFO - mozversion application_remotingname: firefox 23:39:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:39:53 INFO - mozversion application_vendor: Mozilla 23:39:53 INFO - mozversion application_version: 49.0a1 23:39:53 INFO - mozversion platform_buildid: 20160427173008 23:39:53 INFO - mozversion platform_changeset: d14d6f68201e667c9a73f9dc1917b5a9505f845a 23:39:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:39:53 INFO - mozversion platform_version: 49.0a1 23:39:53 INFO - using testdate: 1461825593 23:39:53 INFO - actual date: 1461825593 23:39:53 INFO - starting webserver on 'localhost:36825' 23:39:53 INFO - SUITE-START | Running 2 tests 23:39:53 INFO - TEST-START | dromaeo_css 23:39:53 INFO - operating with platform_type : linux_ 23:39:53 INFO - Initialising browser for dromaeo_css test... 23:39:53 INFO - TEST-INFO | started process 31634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1UlMo/profile http://localhost:36825/getInfo.html) 23:39:57 INFO - PROCESS | 31634 | __metrics Screen width/height:1600/1200 23:39:57 INFO - PROCESS | 31634 | colorDepth:24 23:39:57 INFO - PROCESS | 31634 | Browser inner width/height: 1024/697 23:39:57 INFO - PROCESS | 31634 | __metrics 23:39:58 ERROR - PROCESS | 31634 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:39:59 INFO - TEST-INFO | 31634: exit 0 23:39:59 INFO - Browser initialized. 23:39:59 INFO - Running cycle 1/1 for dromaeo_css test... 23:39:59 INFO - TEST-INFO | started process 31715 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1UlMo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:40:10 INFO - PROCESS | 31715 | RSS: Main: 154271744 23:40:10 INFO - PROCESS | 31715 | 23:41:02 INFO - PROCESS | 31715 | 1461825662121 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] 23:43:09 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36825/tests/dromaeo/cssquery-ext.html) 23:43:10 INFO - PROCESS | 31715 | RSS: Main: 235864064 23:43:10 INFO - PROCESS | 31715 | 23:46:12 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-ext.html (next: http://localhost:36825/tests/dromaeo/cssquery-jquery.html) 23:46:13 INFO - PROCESS | 31715 | RSS: Main: 237633536 23:46:13 INFO - PROCESS | 31715 | 23:49:15 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36825/tests/dromaeo/cssquery-mootools.html) 23:49:15 INFO - PROCESS | 31715 | RSS: Main: 234135552 23:49:15 INFO - PROCESS | 31715 | 23:52:17 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36825/tests/dromaeo/cssquery-prototype.html) 23:52:18 INFO - PROCESS | 31715 | RSS: Main: 232480768 23:52:18 INFO - PROCESS | 31715 | 23:55:20 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36825/tests/dromaeo/cssquery-yui.html) 23:55:21 INFO - PROCESS | 31715 | RSS: Main: 216395776 23:55:21 INFO - PROCESS | 31715 | 23:58:23 INFO - PROCESS | 31715 | Cycle 1(1): loaded http://localhost:36825/tests/dromaeo/cssquery-yui.html (next: http://localhost:36825/tests/dromaeo/cssquery-dojo.html) 23:58:24 INFO - PROCESS | 31715 | RSS: Main: 266223616 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | __start_tp_report 23:58:24 INFO - PROCESS | 31715 | _x_x_mozilla_page_load 23:58:24 INFO - PROCESS | 31715 | _x_x_mozilla_page_load_details 23:58:24 INFO - PROCESS | 31715 | |i|pagename|runs| 23:58:24 INFO - PROCESS | 31715 | |0;dojo.html;3079.184016235698;3126.734227590655;3143.6070491188616;3166.2401023754305;3196.680331966803;5115.9744201278945;5210.635255532115;5227.5295223429885;5289.180177072555;5295.258663787068;5102.260172275027;5149.716765577892;5184.066867963775;5247.47525247476;5268.130758424865;4670.1126785910565;4723.385959825235;4726.952730472694;4773.045390921812;4882.511748825107;4820.517948205186;4866.270059491069;4880.267959806022;4880.902381952359;4893.41279046515;4650.95349046512;4671.649626278026;4736.147493451177;4736.786844591985;4844.176489996691;4687.718736875764;4714.834980775657;4723.244280915037;4726.1020406122725;4769.856904292842;4698.718076915396;4702.412198475191;4706.482286948433;4708.03485285519;4752.500987396308;4995.425526064513;5128.615353848476;5157.8452646420665;5236.502532259429;5254.553362964114;5508.9724551377385;5518.475744804237;5546.889062218733;5557.360903496109;5563.888722225533;5577.609567330289;5582.413846546136;5590.552755779528;5590.776368945238;5595.272614560122;5156.639035267533;5232.110541208004;5255.947440525546;5318.5213330800025;5332.866678333034;5623.578231632644;5632.831015069554;5636.943630563724;5639;5683.346415162227;5398.325209348832;5430.972845135749;5432.646877953;5441.292631957899;5442.727863606804;5478.945210547843;5557.5553955683445;5561.360443549043;5579.888402231933;5592.720363981784;5512.862178445571;5523.889522209533;5527.778888844482;5532.059549876531;5541.722913854291;5478.863028424242;5518.834434966958;5518.972405137949;5540.695261760561;5562.193481945095;4269.167512335065;4277.059047009653;4280.101178752435;4317.373980772771;4320.4599425071865;3793.374093274634;3820.8662696806036;3831.578526362098;3865.536135663738;3867.207222519377;5138.948610513847;5220.451852555503;5224.634275600747;5293.497117773883;5319.893602127936;5581.386047534768;5605.635633683797;5608.298962629671;5651.773929042874;5660.29246344207;5268.710220937808;5274.815381461707;5275.340582427197;5282.286891269629;5324.92012619811;4676.836310729176;4754.381930349033;4769.070031343855;4800.951990480051;4814.133455977888;5694.686792226467;5695.487406133385;5703.030484817591;5731.484166425042;5751.741171647286;5516.641418307797;5519.144532597454;5519.448055194448;5520.475554822286;5526.47498487643;5606.971965140148;5681.375048744718;5692;5749.425057494217;5798.507126894261;5422.972885135549;5432.076546986943;5432.1308590626895;5433.266509021231;5486.478784515464;5494.80768173112;5529.502344788988;5534.695591742332;5548.861278468071;5589.413111623384;5337.839864804062;5384.7576859040655;5431.022415965006;5461.098918678374;5487.122060470306;5505.449455054462;5518.641288316247;5525.530329921841;5528.336599608073;5532.2254884315425;5415.6479828811;5433.375161856279;5439.836804895859;5442.510174084351;5487.670739755627;5356.651817631841;5497.45025497447;5513.558915286687;5538.086215774352;5560.138178582326;5309.495597918191;5310.946890531045;5313.362396512443;5313.973430132824;5370.409254982027 23:58:24 INFO - PROCESS | 31715 | |1;ext.html;599.7840777320164;629.7638385605395;640.51320996043;644.4618743349303;652.8008957268034;29444.55833162504;35841;36716.81641591795;36723.81638091809;36725.44911826325;37054;37718.0570485738;37741.81129094357;37784;37895.431568526496;8266.504009759403;8475.364347673918;8477.067522572512;8478.491290522557;8488.702895398663;8296.294814940737;8427.620757065915;8429.536375499345;8430.199131082569;8677.435966662179;8730.214280714734;8805.955970220171;8810.251128654072;8812.691555795549;8812.867806982867;8657.307415406753;8727.0836562161;8732.083131271189;8735.257503112243;8739.4756314621;8511.489310641382;8632.65469381224;8647.740567782977;8653.65868290416;8659.826803463895;38854.805725971186;39157;39298;39334.60665393367;39358.835264060464;3403.1662242750435;3463.7402194835236;3473.6873681368547;3489.2149266414854;3865;29444.26389340262;29899.70100298991;30172;30338;30602;4233.724807887508;4280.5719428057255;4362.105768317488;4385.605295523386;4417.668674849399;254827;256580;256974;257871;258022.70988645125;51707.741461292455;51745.74127129416;52071.47928520666;52163.73918130461;52185.73907130516;44721.77639111783;44925.77537112294;45983.54016459793;45995.77002115035;54470.72764636151;13792.724145517233;14199.503017394341;14204;14214;14231;10964.396958167377;11040;11047.447627618747;11057.281276717149;11059.170562207866;12936.805947910789;13941.58175254744;14510.347034383478;14526.418943242152;14535.27323633814;5898.410158984153;5927.733252003584;6065.088757396475;6065.848353791191;6125.7839634192405;1032.8708911386077;1099.9770213701336;1102.895224953628;1114.2812885688686;1162.9825552616717;29677.406451871273;29764.2558936024;30190.69809301923;30820.22949426282;31101.53347699786;1103.5594519021301;1155.78040172367;1215.3497878634887;1219.603628820637;1221.877812218771;15990.271471788754;16056.67886642284;16082.919585401998;16233.756493652605;16437.506874793777;342870;347032;347854;349030;349847;46278.53721462809;46343.07313853704;52195.47804521906;52360.738196308776;52492.95014099773;1287.9871201288054;1381;1390.3326403326257;1455.7379671659203;1490.5602847160114;27257.59113613337;28577.285567860137;29868;31085;31412.68587314189;40816.79591602023;40993.385099224135;41166.1766764657;41680;42323.365149522164;253820;255834;255934;256237;256295;29748.40503189881;33793.324133517686;34942.65057349495;34976.475352870235;35424.291514169054;39002;39432.21135577215;39599;40549.1890162201;40602.593974059884;33804.66195338015;34522.65477345194;34761.304773904885;34873.30253394969;35180.472292916136;33922.83038584791;34024.82987585046;34036.319273613895;34268.657313427546;37621.81189094037;37817;38167.80916095402;38213.808930955165;38602.42096368501;38680.41979370255;33912.83043584766;34357.48463773095;34689.82655086708;34991.82504087463;35208.295834083685;24326.51346973086;24802.751972480044;25879.48241035131;25977.870110649324;26921.86539067292 23:58:24 INFO - PROCESS | 31715 | |2;jquery.html;396.8630822366286;397.19766072533474;400.38940615561285;402.5431135661024;417.41978649676935;16789.328426862925;17236.138193090326;17396.56508587286;17419;18156.092195390243;16491.422800201995;16911.57721056971;17155.571110722238;17465.214065367058;18061.27754889803;5434.239206511092;5446.972765136179;5647.463490968372;5674.914876276859;5675.4608312210485;5524.613277070606;5547.500724934755;5592.3009623797025;5594;5595.888082238353;5371.167469042305;5573.386927437979;5579.748911298981;5590.02174619442;5591.440855914417;5592.496675299242;5615.073512870413;5631.2960879890015;5663.943360566383;5664.886702265972;5267.104592219332;5454.699991500466;5466.562674985991;5479.726013699339;5493.642913210629;12513.249205047727;12611;12634.936825315815;12762.489500419972;17248.82751172485;2074.7406574178226;2196.8022877940903;2405.747396523375;2523.2430270918653;2920.6349206349205;9406.482643454607;9567.856482152773;9848.90151098487;9974.152197063258;12503.562375316911;1827.2234300422267;1882.7928927818066;1888.688366419553;1914.4161030885575;1937.302571074412;64991.82577655115;66263.66868165629;67092;67513;67622.66188669026;10539.894601053891;10638.574457021787;10676.626318078985;10715.24993250465;10718.196135289885;14779.408823647149;14796.48212312564;14838.777418338734;14847.703045939237;14850.108993460211;7445.404367650575;7683.0780306363595;7708.2291770823595;7781.26078022587;7804.024496937883;7076.32774886385;7118.786436406916;7153.427725781925;7390.113186417557;7422.443316751265;4604.470485894165;4703.223968045234;4714.3871296731895;4720.409948756405;4742.715437073786;1878.8872667639985;1939.6023815117867;1958.3831093205595;1980.4058782365232;2012.1347820437352;935.4340623922565;975.7170420578095;1003.7641154328727;1006.7986402719486;1050.1336397472116;18261.360852370104;18665.720014199796;18707.90646046761;18794.342198023005;19053.142608582646;972.3582435592475;987.4963768478128;1022.1209759606733;1034.4103860799423;1072.3405105859997;9986.400815951067;10179.949100254451;10733;10779.197408673801;10808.351498910091;483530;487906;490469;501255;502930;77309.61345193238;77551.61224193843;77881;78111;79350.6032469834;1075.064693716456;1077.1921059205595;1083.0523292119397;1106.5463160104318;1134.931904085741;16854.807125045354;16928.74606880873;17037.744433833752;17103.230354633823;17309.65380692404;25298.494030119662;26459.33851653647;34359.48460773141;37137;37968.810155949046;45796;48361.75819120882;50245.74877125737;50847.745761270955;51662.22506662328;8102.177010172664;8451.746447606582;8480.660773568989;8529.402941794015;8619.353548484014;12630.368481576068;12859.678508037;12960.93519532434;13023.348832558144;13159.934200328937;11026.117910567296;11394.601188958346;11541.596044138414;11624.82562761576;11865.940670296593;6402.87194256103;10239.48802559884;11034.889651103707;11152.553897843994;11182.496787644413;11655.59205427806;11756;11783.351915644722;11794.941025294818;12308.569200077955;8505.787355316166;8515.446495977742;8536.70121545743;8554.957225214082;8723.389362744547;8757.956210218908;11650.184487085822;12005.219660722025;12094;12226.021918246697 23:58:24 INFO - PROCESS | 31715 | |3;mootools.html;1407.7114191590724;1506.216767281014;1513.6064623197967;1660.676168147211;1806.6296409236109;7773.378129749621;8057.516549007049;8069.547481453336;8098.2306680865295;8116.797080072994;7879.975603171594;8089.999999999985;8184.877226841602;8192.877106843387;8204.794880128;1997.0813425824138;2055.794420557947;2056.1055940665783;2278.065992942894;2295.150794206146;2262.66060090986;2335.0309621507054;2335.801456876159;2335.9182428615004;2338.205010296499;2215.3686199433164;2233.542123864604;2234.2626933112115;2242.248846636379;2261.525079733258;1997.5805080933021;2246.7416247131628;2252.966205506919;2263.196565219348;2263.9886800565973;2285.6914316567218;2289.0614847912443;2289.8740569268684;2320.037184568402;2323.5236776460783;7609.581473018981;7665.770026899147;7669.463137580372;7670.30967212948;7752.806179845493;4622.1911165546235;4823.20417131173;4824.8311309104365;4846.515348465161;4864.586510146642;3082.475979083561;3145.3237553925787;3295.07737833407;3313.122022663996;3326.4843949187916;1114.4594871487323;1127.3799410324289;1141.2353723005606;1147.1511081799408;1155.2086820527966;11238.943805280922;11248.94375528117;11251.831222531751;11308.886911130865;11313.717157071056;4374.19077470669;4403.4495688039;4495.595396414338;4496.078303947683;4507.346434767006;9660.420374777535;9713.90286097144;9726.902730972599;9735.026497350209;9753.36603120809;4949.65352425334;5010.5240002199735;5013.448520662724;5025.271335656309;5032.169692000779;4058.857939972087;4432;4548.4541854977615;4668.929966050512;4670.602998745077;3760.8871733848027;3794.392897136445;3863.478430411915;3890.008047947755;3893.5133108361456;1205.3250179899285;1230.1511956749814;1235.0983781839127;1246.1463897230426;1262.450833887262;976.5800705696619;981.0924894472585;990.6928852055886;997.546116516983;1015.9796804063877;5429.837104886859;5489.615726899079;5576.498115169654;5641.605087643826;5648;403.9656629186552;409.2183928696176;414.93153629651374;419.1805021183579;420.24775651583326;3873.2253549290253;3899.8830035098426;3908.3160446922243;3932.4691166692132;3980.5223373195404;9573.28200384974;9828.754281143028;10158.695239142837;10183;10183.083522483012;9711.611535538641;9921.156701680438;10024.24818138628;10133.746656333651;10142.797144057078;7633.427492938052;7689.807754806175;7820.843583128306;7853.900453936453;7911.446198766032;5636.239107720406;5695.145728140812;5752.827415177551;5788.131780232999;5945.970270148621;9417.434953902788;9430;9500.192483638968;9529.761755956157;9696.224302055678;9547;9608.375455595364;9629.796275465567;9712.562934667816;9722.75693107678;6564.868702626016;6934.93065069363;7090;7294.270572942875;7376.852462950604;7639.618019098912;7668.156502784577;7702.075750909927;7741.883871741816;7746.57393843344;6889.793306200822;7035.929640703527;7063.046488723957;7116.50184487081;7235.674394652358;7073.3987611053635;7103.680334384861;7126.893096603659;7178.425725941807;7185.892211616934;6376.681165941777;6478.5141114415665;6513.316101809241;6547.050677651809;6559.868802624016;4937;5003.399592048978;5017.24741288795;5031.899362012812;5084.771185296597;4916.311716359784;4990.301357809982;5016.272640467185;5016.924746128738;5061.215511595708 23:58:24 INFO - PROCESS | 31715 | |4;prototype.html;327.3436759297608;328.5958271326269;332.51452878796965;335.6509230400382;337.3876414308032;5218.869528261791;5298.443663415339;5307.548858347045;5309.044372013041;5321.52106310432;5222.190560463125;5258.316418865552;5260.184671375933;5261.421243663194;5270.683758974455;3879.5926427725035;3961.1285517186175;4048.7651266363746;4094.549599544063;4146.896327591804;4037.6769858411403;4082.775167449768;4113.403556484308;4118.608732170439;4124.0720837811405;3905.9609403906024;4053.817578208973;4084.2852500812237;4095.651869591088;4106.650934670557;3929.685625149981;4011.7994100295014;4038.9394159087637;4041.6564592009713;4074.348104303297;3540.2565461253166;3569.5181150544604;3570.3037907608027;3575.106223444139;3592.7125829933543;5058.620603454756;5079;5084.8220312288895;5094.4650811664615;5098.923516147261;4509.210888094571;4630;4631.397918270637;4654.045920586305;4692.882677933045;5423.918641220384;5455.863603409907;5459.645123066988;5466.808661696861;5489.368722596912;3956.2285354355913;3959.109200429909;3963.980180099081;3974.701897357681;3988.760674359548;5593.496585307301;5593.496585307342;5652.519535839418;5689.829305120853;5698.40166782486;4036.334004889219;4041.2927737645796;4043.8180281887385;4050.837966481308;4054.6756259499757;4092.8362865485046;4100.282450571138;4104.610062044101;4115.794210289474;4119.691023173274;4344.9565504344555;4630.930536041962;4633.860984170413;4674.298855171752;4684.789184486706;5487.149491828773;5517.503424691797;5518.144687573433;5529.529989950819;5542.224088627595;1455.4396557325506;1469.2506821520888;1471.4114354258381;1472.85271472854;1473.594761440591;903.5256490342491;932.1983094538691;981.788915383196;982.3172894838019;996.6063404955003;5547.55619550435;5571.220029195916;5577.247071645357;5620.353659329147;5635.323761148688;5945.346011938684;5955.731992060368;5958.851028724316;5969.671668058211;5974.253218347707;5052.898942021213;5363.5440987516495;5383.542398896059;5545.528630066409;5570.610057296031;3228.1445416964525;3233.773635845468;3234.75739319552;3256.055743834309;3258.315753691704;6168.784092556739;6181.830818799741;6266.905996410058;6293.748250069946;6305.211848518935;6152.938470615326;6162.969185154136;6172.6913654318005;6178.907316390258;6188.350223226586;6192.225971753531;6212.782552610637;6221.191245138193;6265.310815810349;6315.684215789101;5971.492423144082;6007.909881351696;6029.698515074141;6050.03373903492;6064.3026052002815;5953.76184952597;5962.761489540369;5963.522918166623;5979.312379076462;5980.641161530322;6062.878742425215;6204.224471941007;6239.625622462667;6270.592411493239;6286.119943207863;4157.875263742093;4181.686373521937;4206.579342065769;4218.409422680888;4220.599043090901;6069.150318955438;6103.633781973096;6129.823912511173;6135.754569817157;6154.415330543591;5137.537621614073;5395.302348825588;5555.333359996826;5608.915866262091;5923.378045305181;5525.751341189576;5526.613137080366;5539.7230138492105;5546.670398432749;5548.667079975215;5250.789968401221;5424.376196737426;5469.781208751605;5474.233607295061;5494.395616482104;5533.197686335539;5563.8887222256135;5565.220869078414;5591.27313449249;5594.216809646734;5414.214938833926;5419.295491586068;5505.339359276913;5513;5519.785647157619 23:58:24 INFO - PROCESS | 31715 | |5;yui.html;823.8846561481394;851.7444766570028;858.5707146426787;861.4615865084322;870.2646263906996;13628.659283517916;13926.930365348171;13940.581782546515;13956.162630242192;13957.860421395782;12718.109732318719;13144.73710525789;13177.538786142486;13195.868041319583;13271.734565308712;692.2143367278126;795.6737737527615;806.8749343851713;818.1368656067846;827.148037521354;815.8490679224362;816.8529664660359;825.1830687619243;826.2357319479457;827.4538804389105;716.2014353995283;852.1733918099465;852.4033176776281;852.688768599463;856.2850020233113;722.50869408802;726.1902978179319;828.200786241277;854.0605334132466;854.7435769269194;622.3776223776224;622.4677900395142;623.0965100604142;624.1636207481951;624.2290770897937;13994.370253338624;14216.075955062888;14223.359948802328;14236.857631423656;14241.287935603179;13179.472821087242;13542.322883855866;13600;13726.794098088536;14100.365483553265;11158;11278.266912650652;11465.656030319104;11724.179307448481;11770.205951250091;3813.351730205844;3947.6841852652005;3951.802409879523;3958.8614398495915;3981.6615587675083;49948.50051499475;52023.73988130073;56987.43012569863;57503.42496575022;58113;10268.383896966207;10360.889384318278;10366.688999330032;10768.946155269174;11030.50362733679;19293.228270869287;19340.516487087934;19358.612827743367;19383.612327753366;20138.093785779674;8997.145271199226;9018.053104423941;9035.593398297093;9040.773980650536;9169.128932751379;4795.304680821261;4829.613630909519;4884.389451318585;4939.678920870132;5134.640575159703;3209.3902158589794;3296.7362610991545;3351.4470112431177;3352.5976882773734;3358.4794356874722;638.1831255992337;649.8667773106501;659.1496968910052;659.535027805396;662.3343539742624;618.8916939535563;660.3264670036535;664.2792570061441;691.5021184746975;695.1935754524727;9327.860082098774;9488.620455181854;9549.61801527945;9616.182624476998;9649.372790768577;563.5238223700966;636.2047440699126;649.7790751144634;666.1440049536322;703.2756261051126;4110.671146308288;4232.724872883253;4292.5063617683745;4388.1223755249075;4406.669499787465;52370;55949.72025139848;56476.152857707166;70241.64879175674;72383.6380818103;49864;50665.49334506682;56010;56624;57154.14268785971;51711.74144129331;51723.224151637754;51893.22160167601;53402.73298633482;53732.731336343066;9524.380915240765;9582.568784404857;9628.422294662343;9695.127438530566;9798.118169364792;32458.67541324651;32947;33330.500042499865;34071.65928340685;34756.131096722784;44956.550434495235;45294.54705452903;45507.54492455033;45721.77139114283;45852.082958341314;11949.940250299042;12235.632931012084;12300.261984280973;12300.323482208565;12352.444140013542;13439.596812095653;13551.796723048965;14067.155970641794;14290.928545357623;14391.640208994859;8602.693852883156;11253.7749245013;11961.820572691591;11984;12006.039516838806;12488.125831192092;12744.872551274368;12856.678583035125;12898.48406063747;12921.61235162909;11866.584669536525;12118.697032574257;12484.063695222712;12725.87274127247;12835.229886206858;9952.800943981225;9963.302568820112;10038.19694424459;10160.390376577428;10188.439635820101;9733.853992189981;9743.171830394496;10205.795884082425;10307.484625768831;10332 23:58:24 INFO - PROCESS | 31715 | __end_tp_report 23:58:24 INFO - PROCESS | 31715 | __start_cc_report 23:58:24 INFO - PROCESS | 31715 | _x_x_mozilla_cycle_collect,1005 23:58:24 INFO - PROCESS | 31715 | __end_cc_report 23:58:24 INFO - PROCESS | 31715 | __startTimestamp1461826704204__endTimestamp 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | ------- Summary: start ------- 23:58:24 INFO - PROCESS | 31715 | Number of tests: 6 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#0] dojo.html Cycles:165 Average:5173.67 Median:5384.76 stddev:560.25 (10.4%) stddev-sans-first:537.34 23:58:24 INFO - PROCESS | 31715 | Values: 3079.2 3126.7 3143.6 3166.2 3196.7 5116.0 5210.6 5227.5 5289.2 5295.3 5102.3 5149.7 5184.1 5247.5 5268.1 4670.1 4723.4 4727.0 4773.0 4882.5 4820.5 4866.3 4880.3 4880.9 4893.4 4651.0 4671.6 4736.1 4736.8 4844.2 4687.7 4714.8 4723.2 4726.1 4769.9 4698.7 4702.4 4706.5 4708.0 4752.5 4995.4 5128.6 5157.8 5236.5 5254.6 5509.0 5518.5 5546.9 5557.4 5563.9 5577.6 5582.4 5590.6 5590.8 5595.3 5156.6 5232.1 5255.9 5318.5 5332.9 5623.6 5632.8 5636.9 5639.0 5683.3 5398.3 5431.0 5432.6 5441.3 5442.7 5478.9 5557.6 5561.4 5579.9 5592.7 5512.9 5523.9 5527.8 5532.1 5541.7 5478.9 5518.8 5519.0 5540.7 5562.2 4269.2 4277.1 4280.1 4317.4 4320.5 3793.4 3820.9 3831.6 3865.5 3867.2 5138.9 5220.5 5224.6 5293.5 5319.9 5581.4 5605.6 5608.3 5651.8 5660.3 5268.7 5274.8 5275.3 5282.3 5324.9 4676.8 4754.4 4769.1 4801.0 4814.1 5694.7 5695.5 5703.0 5731.5 5751.7 5516.6 5519.1 5519.4 5520.5 5526.5 5607.0 5681.4 5692.0 5749.4 5798.5 5423.0 5432.1 5432.1 5433.3 5486.5 5494.8 5529.5 5534.7 5548.9 5589.4 5337.8 5384.8 5431.0 5461.1 5487.1 5505.4 5518.6 5525.5 5528.3 5532.2 5415.6 5433.4 5439.8 5442.5 5487.7 5356.7 5497.5 5513.6 5538.1 5560.1 5309.5 5310.9 5313.4 5314.0 5370.4 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#1] ext.html Cycles:180 Average:44735.46 Median:35086.15 stddev:75794.66 (216.0%) stddev-sans-first:75934.84 23:58:24 INFO - PROCESS | 31715 | Values: 599.8 629.8 640.5 644.5 652.8 29444.6 35841.0 36716.8 36723.8 36725.4 37054.0 37718.1 37741.8 37784.0 37895.4 8266.5 8475.4 8477.1 8478.5 8488.7 8296.3 8427.6 8429.5 8430.2 8677.4 8730.2 8806.0 8810.3 8812.7 8812.9 8657.3 8727.1 8732.1 8735.3 8739.5 8511.5 8632.7 8647.7 8653.7 8659.8 38854.8 39157.0 39298.0 39334.6 39358.8 3403.2 3463.7 3473.7 3489.2 3865.0 29444.3 29899.7 30172.0 30338.0 30602.0 4233.7 4280.6 4362.1 4385.6 4417.7 254827.0 256580.0 256974.0 257871.0 258022.7 51707.7 51745.7 52071.5 52163.7 52185.7 44721.8 44925.8 45983.5 45995.8 54470.7 13792.7 14199.5 14204.0 14214.0 14231.0 10964.4 11040.0 11047.4 11057.3 11059.2 12936.8 13941.6 14510.3 14526.4 14535.3 5898.4 5927.7 6065.1 6065.8 6125.8 1032.9 1100.0 1102.9 1114.3 1163.0 29677.4 29764.3 30190.7 30820.2 31101.5 1103.6 1155.8 1215.3 1219.6 1221.9 15990.3 16056.7 16082.9 16233.8 16437.5 342870.0 347032.0 347854.0 349030.0 349847.0 46278.5 46343.1 52195.5 52360.7 52493.0 1288.0 1381.0 1390.3 1455.7 1490.6 27257.6 28577.3 29868.0 31085.0 31412.7 40816.8 40993.4 41166.2 41680.0 42323.4 253820.0 255834.0 255934.0 256237.0 256295.0 29748.4 33793.3 34942.7 34976.5 35424.3 39002.0 39432.2 39599.0 40549.2 40602.6 33804.7 34522.7 34761.3 34873.3 35180.5 33922.8 34024.8 34036.3 34268.7 37621.8 37817.0 38167.8 38213.8 38602.4 38680.4 33912.8 34357.5 34689.8 34991.8 35208.3 24326.5 24802.8 25879.5 25977.9 26921.9 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#2] jquery.html Cycles:180 Average:27264.18 Median:18640.06 stddev:80797.90 (433.5%) stddev-sans-first:80999.37 23:58:24 INFO - PROCESS | 31715 | Values: 396.9 397.2 400.4 402.5 417.4 16789.3 17236.1 17396.6 17419.0 18156.1 16491.4 16911.6 17155.6 17465.2 18061.3 5434.2 5447.0 5647.5 5674.9 5675.5 5524.6 5547.5 5592.3 5594.0 5595.9 5371.2 5573.4 5579.7 5590.0 5591.4 5592.5 5615.1 5631.3 5663.9 5664.9 5267.1 5454.7 5466.6 5479.7 5493.6 12513.2 12611.0 12634.9 12762.5 17248.8 2074.7 2196.8 2405.7 2523.2 2920.6 9406.5 9567.9 9848.9 9974.2 12503.6 1827.2 1882.8 1888.7 1914.4 1937.3 64991.8 66263.7 67092.0 67513.0 67622.7 10539.9 10638.6 10676.6 10715.2 10718.2 14779.4 14796.5 14838.8 14847.7 14850.1 7445.4 7683.1 7708.2 7781.3 7804.0 7076.3 7118.8 7153.4 7390.1 7422.4 4604.5 4703.2 4714.4 4720.4 4742.7 1878.9 1939.6 1958.4 1980.4 2012.1 935.4 975.7 1003.8 1006.8 1050.1 18261.4 18665.7 18707.9 18794.3 19053.1 972.4 987.5 1022.1 1034.4 1072.3 9986.4 10179.9 10733.0 10779.2 10808.4 483530.0 487906.0 490469.0 501255.0 502930.0 77309.6 77551.6 77881.0 78111.0 79350.6 1075.1 1077.2 1083.1 1106.5 1134.9 16854.8 16928.7 17037.7 17103.2 17309.7 25298.5 26459.3 34359.5 37137.0 37968.8 45796.0 48361.8 50245.7 50847.7 51662.2 8102.2 8451.7 8480.7 8529.4 8619.4 12630.4 12859.7 12960.9 13023.3 13159.9 11026.1 11394.6 11541.6 11624.8 11865.9 6402.9 10239.5 11034.9 11152.6 11182.5 11655.6 11756.0 11783.4 11794.9 12308.6 8505.8 8515.4 8536.7 8555.0 8723.4 8758.0 11650.2 12005.2 12094.0 12226.0 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#3] mootools.html Cycles:180 Average:5410.56 Median:4996.85 stddev:3022.29 (60.5%) stddev-sans-first:3015.80 23:58:24 INFO - PROCESS | 31715 | Values: 1407.7 1506.2 1513.6 1660.7 1806.6 7773.4 8057.5 8069.5 8098.2 8116.8 7880.0 8090.0 8184.9 8192.9 8204.8 1997.1 2055.8 2056.1 2278.1 2295.2 2262.7 2335.0 2335.8 2335.9 2338.2 2215.4 2233.5 2234.3 2242.2 2261.5 1997.6 2246.7 2253.0 2263.2 2264.0 2285.7 2289.1 2289.9 2320.0 2323.5 7609.6 7665.8 7669.5 7670.3 7752.8 4622.2 4823.2 4824.8 4846.5 4864.6 3082.5 3145.3 3295.1 3313.1 3326.5 1114.5 1127.4 1141.2 1147.2 1155.2 11238.9 11248.9 11251.8 11308.9 11313.7 4374.2 4403.4 4495.6 4496.1 4507.3 9660.4 9713.9 9726.9 9735.0 9753.4 4949.7 5010.5 5013.4 5025.3 5032.2 4058.9 4432.0 4548.5 4668.9 4670.6 3760.9 3794.4 3863.5 3890.0 3893.5 1205.3 1230.2 1235.1 1246.1 1262.5 976.6 981.1 990.7 997.5 1016.0 5429.8 5489.6 5576.5 5641.6 5648.0 404.0 409.2 414.9 419.2 420.2 3873.2 3899.9 3908.3 3932.5 3980.5 9573.3 9828.8 10158.7 10183.0 10183.1 9711.6 9921.2 10024.2 10133.7 10142.8 7633.4 7689.8 7820.8 7853.9 7911.4 5636.2 5695.1 5752.8 5788.1 5946.0 9417.4 9430.0 9500.2 9529.8 9696.2 9547.0 9608.4 9629.8 9712.6 9722.8 6564.9 6934.9 7090.0 7294.3 7376.9 7639.6 7668.2 7702.1 7741.9 7746.6 6889.8 7035.9 7063.0 7116.5 7235.7 7073.4 7103.7 7126.9 7178.4 7185.9 6376.7 6478.5 6513.3 6547.1 6559.9 4937.0 5003.4 5017.2 5031.9 5084.8 4916.3 4990.3 5016.3 5016.9 5061.2 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#4] prototype.html Cycles:180 Average:4749.77 Median:5404.76 stddev:1437.02 (26.6%) stddev-sans-first:1402.19 23:58:24 INFO - PROCESS | 31715 | Values: 327.3 328.6 332.5 335.7 337.4 5218.9 5298.4 5307.5 5309.0 5321.5 5222.2 5258.3 5260.2 5261.4 5270.7 3879.6 3961.1 4048.8 4094.5 4146.9 4037.7 4082.8 4113.4 4118.6 4124.1 3906.0 4053.8 4084.3 4095.7 4106.7 3929.7 4011.8 4038.9 4041.7 4074.3 3540.3 3569.5 3570.3 3575.1 3592.7 5058.6 5079.0 5084.8 5094.5 5098.9 4509.2 4630.0 4631.4 4654.0 4692.9 5423.9 5455.9 5459.6 5466.8 5489.4 3956.2 3959.1 3964.0 3974.7 3988.8 5593.5 5593.5 5652.5 5689.8 5698.4 4036.3 4041.3 4043.8 4050.8 4054.7 4092.8 4100.3 4104.6 4115.8 4119.7 4345.0 4630.9 4633.9 4674.3 4684.8 5487.1 5517.5 5518.1 5529.5 5542.2 1455.4 1469.3 1471.4 1472.9 1473.6 903.5 932.2 981.8 982.3 996.6 5547.6 5571.2 5577.2 5620.4 5635.3 5945.3 5955.7 5958.9 5969.7 5974.3 5052.9 5363.5 5383.5 5545.5 5570.6 3228.1 3233.8 3234.8 3256.1 3258.3 6168.8 6181.8 6266.9 6293.7 6305.2 6152.9 6163.0 6172.7 6178.9 6188.4 6192.2 6212.8 6221.2 6265.3 6315.7 5971.5 6007.9 6029.7 6050.0 6064.3 5953.8 5962.8 5963.5 5979.3 5980.6 6062.9 6204.2 6239.6 6270.6 6286.1 4157.9 4181.7 4206.6 4218.4 4220.6 6069.2 6103.6 6129.8 6135.8 6154.4 5137.5 5395.3 5555.3 5608.9 5923.4 5525.8 5526.6 5539.7 5546.7 5548.7 5250.8 5424.4 5469.8 5474.2 5494.4 5533.2 5563.9 5565.2 5591.3 5594.2 5414.2 5419.3 5505.3 5513.0 5519.8 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - PROCESS | 31715 | [#5] yui.html Cycles:180 Average:14785.21 Median:4812.46 stddev:17198.89 (357.4%) stddev-sans-first:17215.18 23:58:24 INFO - PROCESS | 31715 | Values: 823.9 851.7 858.6 861.5 870.3 13628.7 13926.9 13940.6 13956.2 13957.9 12718.1 13144.7 13177.5 13195.9 13271.7 692.2 795.7 806.9 818.1 827.1 815.8 816.9 825.2 826.2 827.5 716.2 852.2 852.4 852.7 856.3 722.5 726.2 828.2 854.1 854.7 622.4 622.5 623.1 624.2 624.2 13994.4 14216.1 14223.4 14236.9 14241.3 13179.5 13542.3 13600.0 13726.8 14100.4 11158.0 11278.3 11465.7 11724.2 11770.2 3813.4 3947.7 3951.8 3958.9 3981.7 49948.5 52023.7 56987.4 57503.4 58113.0 10268.4 10360.9 10366.7 10768.9 11030.5 19293.2 19340.5 19358.6 19383.6 20138.1 8997.1 9018.1 9035.6 9040.8 9169.1 4795.3 4829.6 4884.4 4939.7 5134.6 3209.4 3296.7 3351.4 3352.6 3358.5 638.2 649.9 659.1 659.5 662.3 618.9 660.3 664.3 691.5 695.2 9327.9 9488.6 9549.6 9616.2 9649.4 563.5 636.2 649.8 666.1 703.3 4110.7 4232.7 4292.5 4388.1 4406.7 52370.0 55949.7 56476.2 70241.6 72383.6 49864.0 50665.5 56010.0 56624.0 57154.1 51711.7 51723.2 51893.2 53402.7 53732.7 9524.4 9582.6 9628.4 9695.1 9798.1 32458.7 32947.0 33330.5 34071.7 34756.1 44956.6 45294.5 45507.5 45721.8 45852.1 11949.9 12235.6 12300.3 12300.3 12352.4 13439.6 13551.8 14067.2 14290.9 14391.6 8602.7 11253.8 11961.8 11984.0 12006.0 12488.1 12744.9 12856.7 12898.5 12921.6 11866.6 12118.7 12484.1 12725.9 12835.2 9952.8 9963.3 10038.2 10160.4 10188.4 9733.9 9743.2 10205.8 10307.5 10332.0 23:58:24 INFO - PROCESS | 31715 | -------- Summary: end -------- 23:58:24 INFO - PROCESS | 31715 | 23:58:24 INFO - TEST-INFO | 31715: exit 0 23:58:24 INFO - TEST-OK | dromaeo_css | took 1111688ms 23:58:24 INFO - TEST-START | kraken 23:58:24 INFO - operating with platform_type : linux_ 23:58:24 INFO - Initialising browser for kraken test... 23:58:24 INFO - TEST-INFO | started process 31908 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErpnkx/profile http://localhost:36825/getInfo.html) 23:58:28 INFO - PROCESS | 31908 | __metrics Screen width/height:1600/1200 23:58:28 INFO - PROCESS | 31908 | colorDepth:24 23:58:28 INFO - PROCESS | 31908 | Browser inner width/height: 1024/697 23:58:28 INFO - PROCESS | 31908 | __metrics 23:58:29 ERROR - PROCESS | 31908 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 23:58:30 INFO - TEST-INFO | 31908: exit 0 23:58:30 INFO - Browser initialized. 23:58:30 INFO - Running cycle 1/1 for kraken test... 23:58:30 INFO - TEST-INFO | started process 31990 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpErpnkx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:58:42 INFO - PROCESS | 31990 | RSS: Main: 154509312 23:58:42 INFO - PROCESS | 31990 | 23:58:44 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36825/tests/kraken/driver.html?testName=audio-beat-detection) 23:58:45 INFO - PROCESS | 31990 | RSS: Main: 209715200 23:58:45 INFO - PROCESS | 31990 | 23:58:48 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36825/tests/kraken/driver.html?testName=audio-dft) 23:58:48 INFO - PROCESS | 31990 | RSS: Main: 195067904 23:58:48 INFO - PROCESS | 31990 | 23:58:51 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36825/tests/kraken/driver.html?testName=audio-fft) 23:58:52 INFO - PROCESS | 31990 | RSS: Main: 265932800 23:58:52 INFO - PROCESS | 31990 | 23:58:54 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36825/tests/kraken/driver.html?testName=audio-oscillator) 23:58:55 INFO - PROCESS | 31990 | RSS: Main: 173658112 23:58:55 INFO - PROCESS | 31990 | 23:58:57 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36825/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:58:58 INFO - PROCESS | 31990 | RSS: Main: 178515968 23:58:58 INFO - PROCESS | 31990 | 23:59:01 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36825/tests/kraken/driver.html?testName=imaging-darkroom) 23:59:01 INFO - PROCESS | 31990 | RSS: Main: 214536192 23:59:01 INFO - PROCESS | 31990 | 23:59:04 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36825/tests/kraken/driver.html?testName=imaging-desaturate) 23:59:05 INFO - PROCESS | 31990 | RSS: Main: 215482368 23:59:05 INFO - PROCESS | 31990 | 23:59:08 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36825/tests/kraken/driver.html?testName=json-parse-financial) 23:59:08 INFO - PROCESS | 31990 | RSS: Main: 215810048 23:59:08 INFO - PROCESS | 31990 | 23:59:10 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36825/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:59:11 INFO - PROCESS | 31990 | RSS: Main: 204496896 23:59:11 INFO - PROCESS | 31990 | 23:59:12 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:59:13 INFO - PROCESS | 31990 | RSS: Main: 203874304 23:59:13 INFO - PROCESS | 31990 | 23:59:15 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:59:16 INFO - PROCESS | 31990 | RSS: Main: 215871488 23:59:16 INFO - PROCESS | 31990 | 23:59:18 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:59:19 INFO - PROCESS | 31990 | RSS: Main: 222797824 23:59:19 INFO - PROCESS | 31990 | 23:59:22 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:59:23 INFO - PROCESS | 31990 | RSS: Main: 218673152 23:59:23 INFO - PROCESS | 31990 | 23:59:24 INFO - PROCESS | 31990 | Cycle 1(1): loaded http://localhost:36825/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36825/tests/kraken/driver.html?testName=ai-astar) 23:59:25 INFO - PROCESS | 31990 | RSS: Main: 283111424 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | __start_tp_report 23:59:25 INFO - PROCESS | 31990 | _x_x_mozilla_page_load 23:59:25 INFO - PROCESS | 31990 | _x_x_mozilla_page_load_details 23:59:25 INFO - PROCESS | 31990 | |i|pagename|runs| 23:59:25 INFO - PROCESS | 31990 | |0;ai-astar;111;112;106;110;111;113;102;110;110;111 23:59:25 INFO - PROCESS | 31990 | |1;audio-beat-detection;154;127;160;181;129;158;157;133;189;127 23:59:25 INFO - PROCESS | 31990 | |2;audio-dft;161;159;160;159;159;161;160;161;161;161 23:59:25 INFO - PROCESS | 31990 | |3;audio-fft;73;76;104;116;72;72;72;124;100;76 23:59:25 INFO - PROCESS | 31990 | |4;audio-oscillator;94;94;165;94;92;93;152;93;92;149 23:59:25 INFO - PROCESS | 31990 | |5;imaging-gaussian-blur;117;117;117;117;116;117;118;118;118;118 23:59:25 INFO - PROCESS | 31990 | |6;imaging-darkroom;145;146;145;146;145;146;146;146;146;145 23:59:25 INFO - PROCESS | 31990 | |7;imaging-desaturate;94;94;94;95;94;94;94;94;95;95 23:59:25 INFO - PROCESS | 31990 | |8;json-parse-financial;57;57;56;56;55;57;60;74;54;55 23:59:25 INFO - PROCESS | 31990 | |9;json-stringify-tinderbox;64;64;63;64;64;63;63;63;64;64 23:59:25 INFO - PROCESS | 31990 | |10;stanford-crypto-aes;77;77;76;77;86;76;77;78;79;77 23:59:25 INFO - PROCESS | 31990 | |11;stanford-crypto-ccm;133;142;131;142;126;123;126;129;159;134 23:59:25 INFO - PROCESS | 31990 | |12;stanford-crypto-pbkdf2;219;207;202;205;205;202;206;205;199;204 23:59:25 INFO - PROCESS | 31990 | |13;stanford-crypto-sha256-iterative;70;70;70;70;72;69;67;69;70;69 23:59:25 INFO - PROCESS | 31990 | __end_tp_report 23:59:25 INFO - PROCESS | 31990 | __start_cc_report 23:59:25 INFO - PROCESS | 31990 | _x_x_mozilla_cycle_collect,1613 23:59:25 INFO - PROCESS | 31990 | __end_cc_report 23:59:25 INFO - PROCESS | 31990 | __startTimestamp1461826765095__endTimestamp 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | ------- Summary: start ------- 23:59:25 INFO - PROCESS | 31990 | Number of tests: 14 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.24 (2.9%) stddev-sans-first:3.40 23:59:25 INFO - PROCESS | 31990 | Values: 111.0 112.0 106.0 110.0 111.0 113.0 102.0 110.0 110.0 111.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#1] audio-beat-detection Cycles:10 Average:151.50 Median:157.50 stddev:22.30 (14.2%) stddev-sans-first:23.64 23:59:25 INFO - PROCESS | 31990 | Values: 154.0 127.0 160.0 181.0 129.0 158.0 157.0 133.0 189.0 127.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#2] audio-dft Cycles:10 Average:160.20 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.93 23:59:25 INFO - PROCESS | 31990 | Values: 161.0 159.0 160.0 159.0 159.0 161.0 160.0 161.0 161.0 161.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#3] audio-fft Cycles:10 Average:88.50 Median:72.00 stddev:20.44 (28.4%) stddev-sans-first:20.89 23:59:25 INFO - PROCESS | 31990 | Values: 73.0 76.0 104.0 116.0 72.0 72.0 72.0 124.0 100.0 76.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#4] audio-oscillator Cycles:10 Average:111.80 Median:93.00 stddev:30.32 (32.6%) stddev-sans-first:31.46 23:59:25 INFO - PROCESS | 31990 | Values: 94.0 94.0 165.0 94.0 92.0 93.0 152.0 93.0 92.0 149.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.50 stddev:0.67 (0.6%) stddev-sans-first:0.71 23:59:25 INFO - PROCESS | 31990 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 118.0 118.0 118.0 118.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#6] imaging-darkroom Cycles:10 Average:145.60 Median:146.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 23:59:25 INFO - PROCESS | 31990 | Values: 145.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 23:59:25 INFO - PROCESS | 31990 | Values: 94.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 95.0 95.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#8] json-parse-financial Cycles:10 Average:58.10 Median:57.00 stddev:5.82 (10.2%) stddev-sans-first:6.16 23:59:25 INFO - PROCESS | 31990 | Values: 57.0 57.0 56.0 56.0 55.0 57.0 60.0 74.0 54.0 55.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#9] json-stringify-tinderbox Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.53 23:59:25 INFO - PROCESS | 31990 | Values: 64.0 64.0 63.0 64.0 64.0 63.0 63.0 63.0 64.0 64.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#10] stanford-crypto-aes Cycles:10 Average:78.00 Median:77.00 stddev:2.94 (3.8%) stddev-sans-first:3.10 23:59:25 INFO - PROCESS | 31990 | Values: 77.0 77.0 76.0 77.0 86.0 76.0 77.0 78.0 79.0 77.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#11] stanford-crypto-ccm Cycles:10 Average:134.50 Median:133.50 stddev:10.72 (8.0%) stddev-sans-first:11.36 23:59:25 INFO - PROCESS | 31990 | Values: 133.0 142.0 131.0 142.0 126.0 123.0 126.0 129.0 159.0 134.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:205.40 Median:205.00 stddev:5.32 (2.6%) stddev-sans-first:2.47 23:59:25 INFO - PROCESS | 31990 | Values: 219.0 207.0 202.0 205.0 205.0 202.0 206.0 205.0 199.0 204.0 23:59:25 INFO - PROCESS | 31990 | 23:59:25 INFO - PROCESS | 31990 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:70.00 stddev:1.26 (1.8%) stddev-sans-first:1.33 23:59:25 INFO - PROCESS | 31990 | Values: 70.0 70.0 70.0 70.0 72.0 69.0 67.0 69.0 70.0 69.0 23:59:25 INFO - PROCESS | 31990 | -------- Summary: end -------- 23:59:25 INFO - PROCESS | 31990 | 23:59:26 INFO - TEST-INFO | 31990: exit 0 23:59:26 INFO - TEST-OK | kraken | took 61232ms 23:59:26 INFO - SUITE-END | took 1172s 23:59:26 INFO - Completed test suite (00:19:33) 23:59:26 INFO - javascript benchmark 23:59:26 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3079.184016235698, 3126.734227590655, 3143.6070491188616, 3166.2401023754305, 3196.680331966803, 5115.9744201278945, 5210.635255532115, 5227.5295223429885, 5289.180177072555, 5295.258663787068, 5102.260172275027, 5149.716765577892, 5184.066867963775, 5247.47525247476, 5268.130758424865, 4670.1126785910565, 4723.385959825235, 4726.952730472694, 4773.045390921812, 4882.511748825107, 4820.517948205186, 4866.270059491069, 4880.267959806022, 4880.902381952359, 4893.41279046515, 4650.95349046512, 4671.649626278026, 4736.147493451177, 4736.786844591985, 4844.176489996691, 4687.718736875764, 4714.834980775657, 4723.244280915037, 4726.1020406122725, 4769.856904292842, 4698.718076915396, 4702.412198475191, 4706.482286948433, 4708.03485285519, 4752.500987396308, 4995.425526064513, 5128.615353848476, 5157.8452646420665, 5236.502532259429, 5254.553362964114, 5508.9724551377385, 5518.475744804237, 5546.889062218733, 5557.360903496109, 5563.888722225533, 5577.609567330289, 5582.413846546136, 5590.552755779528, 5590.776368945238, 5595.272614560122, 5156.639035267533, 5232.110541208004, 5255.947440525546, 5318.5213330800025, 5332.866678333034, 5623.578231632644, 5632.831015069554, 5636.943630563724, 5639.0, 5683.346415162227, 5398.325209348832, 5430.972845135749, 5432.646877953, 5441.292631957899, 5442.727863606804, 5478.945210547843, 5557.5553955683445, 5561.360443549043, 5579.888402231933, 5592.720363981784, 5512.862178445571, 5523.889522209533, 5527.778888844482, 5532.059549876531, 5541.722913854291, 5478.863028424242, 5518.834434966958, 5518.972405137949, 5540.695261760561, 5562.193481945095, 4269.167512335065, 4277.059047009653, 4280.101178752435, 4317.373980772771, 4320.4599425071865, 3793.374093274634, 3820.8662696806036, 3831.578526362098, 3865.536135663738, 3867.207222519377, 5138.948610513847, 5220.451852555503, 5224.634275600747, 5293.497117773883, 5319.893602127936, 5581.386047534768, 5605.635633683797, 5608.298962629671, 5651.773929042874, 5660.29246344207, 5268.710220937808, 5274.815381461707, 5275.340582427197, 5282.286891269629, 5324.92012619811, 4676.836310729176, 4754.381930349033, 4769.070031343855, 4800.951990480051, 4814.133455977888, 5694.686792226467, 5695.487406133385, 5703.030484817591, 5731.484166425042, 5751.741171647286, 5516.641418307797, 5519.144532597454, 5519.448055194448, 5520.475554822286, 5526.47498487643, 5606.971965140148, 5681.375048744718, 5692.0, 5749.425057494217, 5798.507126894261, 5422.972885135549, 5432.076546986943, 5432.1308590626895, 5433.266509021231, 5486.478784515464, 5494.80768173112, 5529.502344788988, 5534.695591742332, 5548.861278468071, 5589.413111623384, 5337.839864804062, 5384.7576859040655, 5431.022415965006, 5461.098918678374, 5487.122060470306, 5505.449455054462, 5518.641288316247, 5525.530329921841, 5528.336599608073, 5532.2254884315425, 5415.6479828811, 5433.375161856279, 5439.836804895859, 5442.510174084351, 5487.670739755627, 5356.651817631841, 5497.45025497447, 5513.558915286687, 5538.086215774352, 5560.138178582326, 5309.495597918191, 5310.946890531045, 5313.362396512443, 5313.973430132824, 5370.409254982027], "value": 5138.059319656047, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.7840777320164, 629.7638385605395, 640.51320996043, 644.4618743349303, 652.8008957268034, 29444.55833162504, 35841.0, 36716.81641591795, 36723.81638091809, 36725.44911826325, 37054.0, 37718.0570485738, 37741.81129094357, 37784.0, 37895.431568526496, 8266.504009759403, 8475.364347673918, 8477.067522572512, 8478.491290522557, 8488.702895398663, 8296.294814940737, 8427.620757065915, 8429.536375499345, 8430.199131082569, 8677.435966662179, 8730.214280714734, 8805.955970220171, 8810.251128654072, 8812.691555795549, 8812.867806982867, 8657.307415406753, 8727.0836562161, 8732.083131271189, 8735.257503112243, 8739.4756314621, 8511.489310641382, 8632.65469381224, 8647.740567782977, 8653.65868290416, 8659.826803463895, 38854.805725971186, 39157.0, 39298.0, 39334.60665393367, 39358.835264060464, 3403.1662242750435, 3463.7402194835236, 3473.6873681368547, 3489.2149266414854, 3865.0, 29444.26389340262, 29899.70100298991, 30172.0, 30338.0, 30602.0, 4233.724807887508, 4280.5719428057255, 4362.105768317488, 4385.605295523386, 4417.668674849399, 254827.0, 256580.0, 256974.0, 257871.0, 258022.70988645125, 51707.741461292455, 51745.74127129416, 52071.47928520666, 52163.73918130461, 52185.73907130516, 44721.77639111783, 44925.77537112294, 45983.54016459793, 45995.77002115035, 54470.72764636151, 13792.724145517233, 14199.503017394341, 14204.0, 14214.0, 14231.0, 10964.396958167377, 11040.0, 11047.447627618747, 11057.281276717149, 11059.170562207866, 12936.805947910789, 13941.58175254744, 14510.347034383478, 14526.418943242152, 14535.27323633814, 5898.410158984153, 5927.733252003584, 6065.088757396475, 6065.848353791191, 6125.7839634192405, 1032.8708911386077, 1099.9770213701336, 1102.895224953628, 1114.2812885688686, 1162.9825552616717, 29677.406451871273, 29764.2558936024, 30190.69809301923, 30820.22949426282, 31101.53347699786, 1103.5594519021301, 1155.78040172367, 1215.3497878634887, 1219.603628820637, 1221.877812218771, 15990.271471788754, 16056.67886642284, 16082.919585401998, 16233.756493652605, 16437.506874793777, 342870.0, 347032.0, 347854.0, 349030.0, 349847.0, 46278.53721462809, 46343.07313853704, 52195.47804521906, 52360.738196308776, 52492.95014099773, 1287.9871201288054, 1381.0, 1390.3326403326257, 1455.7379671659203, 1490.5602847160114, 27257.59113613337, 28577.285567860137, 29868.0, 31085.0, 31412.68587314189, 40816.79591602023, 40993.385099224135, 41166.1766764657, 41680.0, 42323.365149522164, 253820.0, 255834.0, 255934.0, 256237.0, 256295.0, 29748.40503189881, 33793.324133517686, 34942.65057349495, 34976.475352870235, 35424.291514169054, 39002.0, 39432.21135577215, 39599.0, 40549.1890162201, 40602.593974059884, 33804.66195338015, 34522.65477345194, 34761.304773904885, 34873.30253394969, 35180.472292916136, 33922.83038584791, 34024.82987585046, 34036.319273613895, 34268.657313427546, 37621.81189094037, 37817.0, 38167.80916095402, 38213.808930955165, 38602.42096368501, 38680.41979370255, 33912.83043584766, 34357.48463773095, 34689.82655086708, 34991.82504087463, 35208.295834083685, 24326.51346973086, 24802.751972480044, 25879.48241035131, 25977.870110649324, 26921.86539067292], "value": 18016.119923574865, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [396.8630822366286, 397.19766072533474, 400.38940615561285, 402.5431135661024, 417.41978649676935, 16789.328426862925, 17236.138193090326, 17396.56508587286, 17419.0, 18156.092195390243, 16491.422800201995, 16911.57721056971, 17155.571110722238, 17465.214065367058, 18061.27754889803, 5434.239206511092, 5446.972765136179, 5647.463490968372, 5674.914876276859, 5675.4608312210485, 5524.613277070606, 5547.500724934755, 5592.3009623797025, 5594.0, 5595.888082238353, 5371.167469042305, 5573.386927437979, 5579.748911298981, 5590.02174619442, 5591.440855914417, 5592.496675299242, 5615.073512870413, 5631.2960879890015, 5663.943360566383, 5664.886702265972, 5267.104592219332, 5454.699991500466, 5466.562674985991, 5479.726013699339, 5493.642913210629, 12513.249205047727, 12611.0, 12634.936825315815, 12762.489500419972, 17248.82751172485, 2074.7406574178226, 2196.8022877940903, 2405.747396523375, 2523.2430270918653, 2920.6349206349205, 9406.482643454607, 9567.856482152773, 9848.90151098487, 9974.152197063258, 12503.562375316911, 1827.2234300422267, 1882.7928927818066, 1888.688366419553, 1914.4161030885575, 1937.302571074412, 64991.82577655115, 66263.66868165629, 67092.0, 67513.0, 67622.66188669026, 10539.894601053891, 10638.574457021787, 10676.626318078985, 10715.24993250465, 10718.196135289885, 14779.408823647149, 14796.48212312564, 14838.777418338734, 14847.703045939237, 14850.108993460211, 7445.404367650575, 7683.0780306363595, 7708.2291770823595, 7781.26078022587, 7804.024496937883, 7076.32774886385, 7118.786436406916, 7153.427725781925, 7390.113186417557, 7422.443316751265, 4604.470485894165, 4703.223968045234, 4714.3871296731895, 4720.409948756405, 4742.715437073786, 1878.8872667639985, 1939.6023815117867, 1958.3831093205595, 1980.4058782365232, 2012.1347820437352, 935.4340623922565, 975.7170420578095, 1003.7641154328727, 1006.7986402719486, 1050.1336397472116, 18261.360852370104, 18665.720014199796, 18707.90646046761, 18794.342198023005, 19053.142608582646, 972.3582435592475, 987.4963768478128, 1022.1209759606733, 1034.4103860799423, 1072.3405105859997, 9986.400815951067, 10179.949100254451, 10733.0, 10779.197408673801, 10808.351498910091, 483530.0, 487906.0, 490469.0, 501255.0, 502930.0, 77309.61345193238, 77551.61224193843, 77881.0, 78111.0, 79350.6032469834, 1075.064693716456, 1077.1921059205595, 1083.0523292119397, 1106.5463160104318, 1134.931904085741, 16854.807125045354, 16928.74606880873, 17037.744433833752, 17103.230354633823, 17309.65380692404, 25298.494030119662, 26459.33851653647, 34359.48460773141, 37137.0, 37968.810155949046, 45796.0, 48361.75819120882, 50245.74877125737, 50847.745761270955, 51662.22506662328, 8102.177010172664, 8451.746447606582, 8480.660773568989, 8529.402941794015, 8619.353548484014, 12630.368481576068, 12859.678508037, 12960.93519532434, 13023.348832558144, 13159.934200328937, 11026.117910567296, 11394.601188958346, 11541.596044138414, 11624.82562761576, 11865.940670296593, 6402.87194256103, 10239.48802559884, 11034.889651103707, 11152.553897843994, 11182.496787644413, 11655.59205427806, 11756.0, 11783.351915644722, 11794.941025294818, 12308.569200077955, 8505.787355316166, 8515.446495977742, 8536.70121545743, 8554.957225214082, 8723.389362744547, 8757.956210218908, 11650.184487085822, 12005.219660722025, 12094.0, 12226.021918246697], "value": 8718.971760249498, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.7114191590724, 1506.216767281014, 1513.6064623197967, 1660.676168147211, 1806.6296409236109, 7773.378129749621, 8057.516549007049, 8069.547481453336, 8098.2306680865295, 8116.797080072994, 7879.975603171594, 8089.999999999985, 8184.877226841602, 8192.877106843387, 8204.794880128, 1997.0813425824138, 2055.794420557947, 2056.1055940665783, 2278.065992942894, 2295.150794206146, 2262.66060090986, 2335.0309621507054, 2335.801456876159, 2335.9182428615004, 2338.205010296499, 2215.3686199433164, 2233.542123864604, 2234.2626933112115, 2242.248846636379, 2261.525079733258, 1997.5805080933021, 2246.7416247131628, 2252.966205506919, 2263.196565219348, 2263.9886800565973, 2285.6914316567218, 2289.0614847912443, 2289.8740569268684, 2320.037184568402, 2323.5236776460783, 7609.581473018981, 7665.770026899147, 7669.463137580372, 7670.30967212948, 7752.806179845493, 4622.1911165546235, 4823.20417131173, 4824.8311309104365, 4846.515348465161, 4864.586510146642, 3082.475979083561, 3145.3237553925787, 3295.07737833407, 3313.122022663996, 3326.4843949187916, 1114.4594871487323, 1127.3799410324289, 1141.2353723005606, 1147.1511081799408, 1155.2086820527966, 11238.943805280922, 11248.94375528117, 11251.831222531751, 11308.886911130865, 11313.717157071056, 4374.19077470669, 4403.4495688039, 4495.595396414338, 4496.078303947683, 4507.346434767006, 9660.420374777535, 9713.90286097144, 9726.902730972599, 9735.026497350209, 9753.36603120809, 4949.65352425334, 5010.5240002199735, 5013.448520662724, 5025.271335656309, 5032.169692000779, 4058.857939972087, 4432.0, 4548.4541854977615, 4668.929966050512, 4670.602998745077, 3760.8871733848027, 3794.392897136445, 3863.478430411915, 3890.008047947755, 3893.5133108361456, 1205.3250179899285, 1230.1511956749814, 1235.0983781839127, 1246.1463897230426, 1262.450833887262, 976.5800705696619, 981.0924894472585, 990.6928852055886, 997.546116516983, 1015.9796804063877, 5429.837104886859, 5489.615726899079, 5576.498115169654, 5641.605087643826, 5648.0, 403.9656629186552, 409.2183928696176, 414.93153629651374, 419.1805021183579, 420.24775651583326, 3873.2253549290253, 3899.8830035098426, 3908.3160446922243, 3932.4691166692132, 3980.5223373195404, 9573.28200384974, 9828.754281143028, 10158.695239142837, 10183.0, 10183.083522483012, 9711.611535538641, 9921.156701680438, 10024.24818138628, 10133.746656333651, 10142.797144057078, 7633.427492938052, 7689.807754806175, 7820.843583128306, 7853.900453936453, 7911.446198766032, 5636.239107720406, 5695.145728140812, 5752.827415177551, 5788.131780232999, 5945.970270148621, 9417.434953902788, 9430.0, 9500.192483638968, 9529.761755956157, 9696.224302055678, 9547.0, 9608.375455595364, 9629.796275465567, 9712.562934667816, 9722.75693107678, 6564.868702626016, 6934.93065069363, 7090.0, 7294.270572942875, 7376.852462950604, 7639.618019098912, 7668.156502784577, 7702.075750909927, 7741.883871741816, 7746.57393843344, 6889.793306200822, 7035.929640703527, 7063.046488723957, 7116.50184487081, 7235.674394652358, 7073.3987611053635, 7103.680334384861, 7126.893096603659, 7178.425725941807, 7185.892211616934, 6376.681165941777, 6478.5141114415665, 6513.316101809241, 6547.050677651809, 6559.868802624016, 4937.0, 5003.399592048978, 5017.24741288795, 5031.899362012812, 5084.771185296597, 4916.311716359784, 4990.301357809982, 5016.272640467185, 5016.924746128738, 5061.215511595708], "value": 4305.306260476179, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.3436759297608, 328.5958271326269, 332.51452878796965, 335.6509230400382, 337.3876414308032, 5218.869528261791, 5298.443663415339, 5307.548858347045, 5309.044372013041, 5321.52106310432, 5222.190560463125, 5258.316418865552, 5260.184671375933, 5261.421243663194, 5270.683758974455, 3879.5926427725035, 3961.1285517186175, 4048.7651266363746, 4094.549599544063, 4146.896327591804, 4037.6769858411403, 4082.775167449768, 4113.403556484308, 4118.608732170439, 4124.0720837811405, 3905.9609403906024, 4053.817578208973, 4084.2852500812237, 4095.651869591088, 4106.650934670557, 3929.685625149981, 4011.7994100295014, 4038.9394159087637, 4041.6564592009713, 4074.348104303297, 3540.2565461253166, 3569.5181150544604, 3570.3037907608027, 3575.106223444139, 3592.7125829933543, 5058.620603454756, 5079.0, 5084.8220312288895, 5094.4650811664615, 5098.923516147261, 4509.210888094571, 4630.0, 4631.397918270637, 4654.045920586305, 4692.882677933045, 5423.918641220384, 5455.863603409907, 5459.645123066988, 5466.808661696861, 5489.368722596912, 3956.2285354355913, 3959.109200429909, 3963.980180099081, 3974.701897357681, 3988.760674359548, 5593.496585307301, 5593.496585307342, 5652.519535839418, 5689.829305120853, 5698.40166782486, 4036.334004889219, 4041.2927737645796, 4043.8180281887385, 4050.837966481308, 4054.6756259499757, 4092.8362865485046, 4100.282450571138, 4104.610062044101, 4115.794210289474, 4119.691023173274, 4344.9565504344555, 4630.930536041962, 4633.860984170413, 4674.298855171752, 4684.789184486706, 5487.149491828773, 5517.503424691797, 5518.144687573433, 5529.529989950819, 5542.224088627595, 1455.4396557325506, 1469.2506821520888, 1471.4114354258381, 1472.85271472854, 1473.594761440591, 903.5256490342491, 932.1983094538691, 981.788915383196, 982.3172894838019, 996.6063404955003, 5547.55619550435, 5571.220029195916, 5577.247071645357, 5620.353659329147, 5635.323761148688, 5945.346011938684, 5955.731992060368, 5958.851028724316, 5969.671668058211, 5974.253218347707, 5052.898942021213, 5363.5440987516495, 5383.542398896059, 5545.528630066409, 5570.610057296031, 3228.1445416964525, 3233.773635845468, 3234.75739319552, 3256.055743834309, 3258.315753691704, 6168.784092556739, 6181.830818799741, 6266.905996410058, 6293.748250069946, 6305.211848518935, 6152.938470615326, 6162.969185154136, 6172.6913654318005, 6178.907316390258, 6188.350223226586, 6192.225971753531, 6212.782552610637, 6221.191245138193, 6265.310815810349, 6315.684215789101, 5971.492423144082, 6007.909881351696, 6029.698515074141, 6050.03373903492, 6064.3026052002815, 5953.76184952597, 5962.761489540369, 5963.522918166623, 5979.312379076462, 5980.641161530322, 6062.878742425215, 6204.224471941007, 6239.625622462667, 6270.592411493239, 6286.119943207863, 4157.875263742093, 4181.686373521937, 4206.579342065769, 4218.409422680888, 4220.599043090901, 6069.150318955438, 6103.633781973096, 6129.823912511173, 6135.754569817157, 6154.415330543591, 5137.537621614073, 5395.302348825588, 5555.333359996826, 5608.915866262091, 5923.378045305181, 5525.751341189576, 5526.613137080366, 5539.7230138492105, 5546.670398432749, 5548.667079975215, 5250.789968401221, 5424.376196737426, 5469.781208751605, 5474.233607295061, 5494.395616482104, 5533.197686335539, 5563.8887222256135, 5565.220869078414, 5591.27313449249, 5594.216809646734, 5414.214938833926, 5419.295491586068, 5505.339359276913, 5513.0, 5519.785647157619], "value": 4295.468924715606, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.8846561481394, 851.7444766570028, 858.5707146426787, 861.4615865084322, 870.2646263906996, 13628.659283517916, 13926.930365348171, 13940.581782546515, 13956.162630242192, 13957.860421395782, 12718.109732318719, 13144.73710525789, 13177.538786142486, 13195.868041319583, 13271.734565308712, 692.2143367278126, 795.6737737527615, 806.8749343851713, 818.1368656067846, 827.148037521354, 815.8490679224362, 816.8529664660359, 825.1830687619243, 826.2357319479457, 827.4538804389105, 716.2014353995283, 852.1733918099465, 852.4033176776281, 852.688768599463, 856.2850020233113, 722.50869408802, 726.1902978179319, 828.200786241277, 854.0605334132466, 854.7435769269194, 622.3776223776224, 622.4677900395142, 623.0965100604142, 624.1636207481951, 624.2290770897937, 13994.370253338624, 14216.075955062888, 14223.359948802328, 14236.857631423656, 14241.287935603179, 13179.472821087242, 13542.322883855866, 13600.0, 13726.794098088536, 14100.365483553265, 11158.0, 11278.266912650652, 11465.656030319104, 11724.179307448481, 11770.205951250091, 3813.351730205844, 3947.6841852652005, 3951.802409879523, 3958.8614398495915, 3981.6615587675083, 49948.50051499475, 52023.73988130073, 56987.43012569863, 57503.42496575022, 58113.0, 10268.383896966207, 10360.889384318278, 10366.688999330032, 10768.946155269174, 11030.50362733679, 19293.228270869287, 19340.516487087934, 19358.612827743367, 19383.612327753366, 20138.093785779674, 8997.145271199226, 9018.053104423941, 9035.593398297093, 9040.773980650536, 9169.128932751379, 4795.304680821261, 4829.613630909519, 4884.389451318585, 4939.678920870132, 5134.640575159703, 3209.3902158589794, 3296.7362610991545, 3351.4470112431177, 3352.5976882773734, 3358.4794356874722, 638.1831255992337, 649.8667773106501, 659.1496968910052, 659.535027805396, 662.3343539742624, 618.8916939535563, 660.3264670036535, 664.2792570061441, 691.5021184746975, 695.1935754524727, 9327.860082098774, 9488.620455181854, 9549.61801527945, 9616.182624476998, 9649.372790768577, 563.5238223700966, 636.2047440699126, 649.7790751144634, 666.1440049536322, 703.2756261051126, 4110.671146308288, 4232.724872883253, 4292.5063617683745, 4388.1223755249075, 4406.669499787465, 52370.0, 55949.72025139848, 56476.152857707166, 70241.64879175674, 72383.6380818103, 49864.0, 50665.49334506682, 56010.0, 56624.0, 57154.14268785971, 51711.74144129331, 51723.224151637754, 51893.22160167601, 53402.73298633482, 53732.731336343066, 9524.380915240765, 9582.568784404857, 9628.422294662343, 9695.127438530566, 9798.118169364792, 32458.67541324651, 32947.0, 33330.500042499865, 34071.65928340685, 34756.131096722784, 44956.550434495235, 45294.54705452903, 45507.54492455033, 45721.77139114283, 45852.082958341314, 11949.940250299042, 12235.632931012084, 12300.261984280973, 12300.323482208565, 12352.444140013542, 13439.596812095653, 13551.796723048965, 14067.155970641794, 14290.928545357623, 14391.640208994859, 8602.693852883156, 11253.7749245013, 11961.820572691591, 11984.0, 12006.039516838806, 12488.125831192092, 12744.872551274368, 12856.678583035125, 12898.48406063747, 12921.61235162909, 11866.584669536525, 12118.697032574257, 12484.063695222712, 12725.87274127247, 12835.229886206858, 9952.800943981225, 9963.302568820112, 10038.19694424459, 10160.390376577428, 10188.439635820101, 9733.853992189981, 9743.171830394496, 10205.795884082425, 10307.484625768831, 10332.0], "value": 6698.583448763466, "unit": "score"}], "name": "dromaeo_css", "value": 6812.831839284616, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 112.0, 106.0, 110.0, 111.0, 113.0, 102.0, 110.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 127.0, 160.0, 181.0, 129.0, 158.0, 157.0, 133.0, 189.0, 127.0], "value": 151.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 159.0, 160.0, 159.0, 159.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 76.0, 104.0, 116.0, 72.0, 72.0, 72.0, 124.0, 100.0, 76.0], "value": 88.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 165.0, 94.0, 92.0, 93.0, 152.0, 93.0, 92.0, 149.0], "value": 111.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0], "value": 145.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0, 95.0, 95.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 57.0, 56.0, 56.0, 55.0, 57.0, 60.0, 74.0, 54.0, 55.0], "value": 58.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 63.0, 64.0, 64.0, 63.0, 63.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 77.0, 86.0, 76.0, 77.0, 78.0, 79.0, 77.0], "value": 78.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 142.0, 131.0, 142.0, 126.0, 123.0, 126.0, 129.0, 159.0, 134.0], "value": 134.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [219.0, 207.0, 202.0, 205.0, 205.0, 202.0, 206.0, 205.0, 199.0, 204.0], "value": 205.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 70.0, 70.0, 72.0, 69.0, 67.0, 69.0, 70.0, 69.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1587.9999999999998, "alertThreshold": 2.0}]} 23:59:26 INFO - Return code: 0 23:59:26 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 23:59:26 ERROR - # TBPL SUCCESS # 23:59:26 INFO - Running post-action listener: _resource_record_post_action 23:59:26 INFO - Running post-run listener: _resource_record_post_run 23:59:27 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 413327360; Read time: 0; Write time: 273248 23:59:27 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 104697856; Read time: 0; Write time: 68708 23:59:27 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 286998528; Read time: 0; Write time: 178224 23:59:27 INFO - Running post-run listener: _upload_blobber_files 23:59:27 INFO - Blob upload gear active. 23:59:27 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:59:27 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:59:27 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:59:27 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:59:27 INFO - (blobuploader) - INFO - Open directory for files ... 23:59:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:59:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:59:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:59:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:59:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:59:28 INFO - (blobuploader) - INFO - Done attempting. 23:59:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:59:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:59:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:59:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:59:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:59:29 INFO - (blobuploader) - INFO - Done attempting. 23:59:29 INFO - (blobuploader) - INFO - Iteration through files over. 23:59:29 INFO - Return code: 0 23:59:29 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:59:29 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:59:29 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b88e255f3f27a1599f78c975919e26c8c743b1ce8a7f13350e0ccf26a852bd71c76e96d793d36a5231b2e267d59fde8211c9c0507f9810fd57ca40ec0d31a86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef634e91efc80d133bb73c993ff8e903a4bcc8ecf241209892eb2c2c05bb1197f182dd082dfdb8fdaad4446968e0fc03d5ccb27927bd31068a0c51aaa562955e"} 23:59:29 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:59:29 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:59:29 INFO - Contents: 23:59:29 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b88e255f3f27a1599f78c975919e26c8c743b1ce8a7f13350e0ccf26a852bd71c76e96d793d36a5231b2e267d59fde8211c9c0507f9810fd57ca40ec0d31a86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef634e91efc80d133bb73c993ff8e903a4bcc8ecf241209892eb2c2c05bb1197f182dd082dfdb8fdaad4446968e0fc03d5ccb27927bd31068a0c51aaa562955e"} 23:59:29 INFO - Running post-run listener: copy_logs_to_upload_dir 23:59:29 INFO - Copying logs to upload dir... 23:59:29 INFO - mkdir: /builds/slave/test/build/upload/logs 23:59:29 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.330498 ========= master_lag: 672.67 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 32 mins, 8 secs) (at 2016-04-28 00:10:41.864852) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 00:10:41.868403) ========= 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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 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/sha512/0b88e255f3f27a1599f78c975919e26c8c743b1ce8a7f13350e0ccf26a852bd71c76e96d793d36a5231b2e267d59fde8211c9c0507f9810fd57ca40ec0d31a86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef634e91efc80d133bb73c993ff8e903a4bcc8ecf241209892eb2c2c05bb1197f182dd082dfdb8fdaad4446968e0fc03d5ccb27927bd31068a0c51aaa562955e"} build_url:https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/XUcNxWo6TQmsrLxBQL0_TQ/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0b88e255f3f27a1599f78c975919e26c8c743b1ce8a7f13350e0ccf26a852bd71c76e96d793d36a5231b2e267d59fde8211c9c0507f9810fd57ca40ec0d31a86", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ef634e91efc80d133bb73c993ff8e903a4bcc8ecf241209892eb2c2c05bb1197f182dd082dfdb8fdaad4446968e0fc03d5ccb27927bd31068a0c51aaa562955e"}' ========= master_lag: 0.26 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 00:10:42.139185) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 00:10:42.139520) ========= 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=0e2a256762fed810e2f0f810000001b3-1461823843.74934-1678173653 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 1.57 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 00:10:43.716838) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-28 00:10:43.717145) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-04-28 00:10:46.305703) ========= ========= Total master_lag: 674.57 =========