builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-019 starttime: 1461143245.26 results: success (0) buildid: 20160419233021 builduid: 4ac88293f1d646a18587e5f3fcfc5fc8 revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.261492) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.261911) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.262199) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.278202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.278468) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 02:07:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-04-20 02:07:25 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.082992 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.374213) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.374515) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020536 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.424679) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:25.425002) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 973dfa15822126c39ea2d98d34ac16643b040243 --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 973dfa15822126c39ea2d98d34ac16643b040243 --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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 02:07:25,871 truncating revision to first 12 chars 2016-04-20 02:07:25,871 Setting DEBUG logging. 2016-04-20 02:07:25,872 attempt 1/10 2016-04-20 02:07:25,872 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/973dfa158221?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 02:07:26,240 unpacking tar archive at: fx-team-973dfa158221/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663239 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:26.100157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:26.100471) ========= script_repo_revision: 973dfa15822126c39ea2d98d34ac16643b040243 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:26.100846) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:26.101123) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:07:26.109461) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-20 02:07:26.109730) ========= /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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:07:26 INFO - MultiFileLogger online at 20160420 02:07:26 in /builds/slave/test 02:07:26 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 02:07:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:07:26 INFO - {'append_to_log': False, 02:07:26 INFO - 'base_work_dir': '/builds/slave/test', 02:07:26 INFO - 'blob_upload_branch': 'Fx-Team', 02:07:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:07:26 INFO - 'branch': 'Fx-Team', 02:07:26 INFO - 'buildbot_json_path': 'buildprops.json', 02:07:26 INFO - 'config_files': ('talos/linux_config.py',), 02:07:26 INFO - 'default_actions': ('clobber', 02:07:26 INFO - 'read-buildbot-config', 02:07:26 INFO - 'download-and-extract', 02:07:26 INFO - 'populate-webroot', 02:07:26 INFO - 'create-virtualenv', 02:07:26 INFO - 'install', 02:07:26 INFO - 'run-tests'), 02:07:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:07:26 INFO - 'download_minidump_stackwalk': True, 02:07:26 INFO - 'download_symbols': 'ondemand', 02:07:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:07:26 INFO - 'tooltool.py': '/tools/tooltool.py', 02:07:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:07:26 INFO - '/tools/misc-python/virtualenv.py')}, 02:07:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:07:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:07:26 INFO - 'installer_path': 'installer.exe', 02:07:26 INFO - 'log_level': 'info', 02:07:26 INFO - 'log_name': 'talos', 02:07:26 INFO - 'log_to_console': True, 02:07:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:07:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:07:26 INFO - 'opt_config_files': (), 02:07:26 INFO - 'pip_index': False, 02:07:26 INFO - 'sps_profile': False, 02:07:26 INFO - 'sps_profile_interval': 0, 02:07:26 INFO - 'suite': 'dromaeojs', 02:07:26 INFO - 'system_bits': '32', 02:07:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:07:26 INFO - 'title': 'talos-linux64-ix-019', 02:07:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:07:26 INFO - 'use_talos_json': True, 02:07:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:07:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:07:26 INFO - 'work_dir': 'build'} 02:07:26 INFO - ##### 02:07:26 INFO - ##### Running clobber step. 02:07:26 INFO - ##### 02:07:26 INFO - Running pre-action listener: _resource_record_pre_action 02:07:26 INFO - Running main action method: clobber 02:07:26 INFO - rmtree: /builds/slave/test/build 02:07:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:07:27 INFO - Running post-action listener: _resource_record_post_action 02:07:27 INFO - ##### 02:07:27 INFO - ##### Running read-buildbot-config step. 02:07:27 INFO - ##### 02:07:27 INFO - Running pre-action listener: _resource_record_pre_action 02:07:27 INFO - Running main action method: read_buildbot_config 02:07:27 INFO - Using buildbot properties: 02:07:27 INFO - { 02:07:27 INFO - "project": "", 02:07:27 INFO - "product": "firefox", 02:07:27 INFO - "script_repo_revision": "production", 02:07:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 02:07:27 INFO - "repository": "", 02:07:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 02:07:27 INFO - "buildid": "20160419233021", 02:07:27 INFO - "pgo_build": "True", 02:07:27 INFO - "basedir": "/builds/slave/test", 02:07:27 INFO - "buildnumber": 47, 02:07:27 INFO - "slavename": "talos-linux64-ix-019", 02:07:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:07:27 INFO - "platform": "ubuntu64_hw", 02:07:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 02:07:27 INFO - "branch": "fx-team", 02:07:27 INFO - "repo_path": "integration/fx-team", 02:07:27 INFO - "revision": "973dfa15822126c39ea2d98d34ac16643b040243", 02:07:27 INFO - "stage_platform": "linux64-pgo", 02:07:27 INFO - "builduid": "4ac88293f1d646a18587e5f3fcfc5fc8", 02:07:27 INFO - "slavebuilddir": "test" 02:07:27 INFO - } 02:07:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 02:07:27 INFO - Running post-action listener: _resource_record_post_action 02:07:27 INFO - ##### 02:07:27 INFO - ##### Running download-and-extract step. 02:07:27 INFO - ##### 02:07:27 INFO - Running pre-action listener: _resource_record_pre_action 02:07:27 INFO - Running main action method: download_and_extract 02:07:27 INFO - mkdir: /builds/slave/test/build/tests 02:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:27 INFO - https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:07:27 INFO - Downloaded 1361 bytes. 02:07:27 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 02:07:27 INFO - Using the following test package requirements: 02:07:27 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:27 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 02:07:27 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 02:07:27 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'jsshell-linux-x86_64.zip'], 02:07:27 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 02:07:27 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 02:07:27 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 02:07:27 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 02:07:27 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 02:07:27 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 02:07:27 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 02:07:27 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:07:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:27 INFO - https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:07:29 INFO - Downloaded 23838449 bytes. 02:07:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:07:30 INFO - Return code: 0 02:07:30 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:07:30 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')]} 02:07:30 INFO - https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:07:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 02:07:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:07:33 INFO - Downloaded 23838449 bytes. 02:07:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:07:34 INFO - Return code: 0 02:07:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:34 INFO - https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:07:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 02:07:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:07:35 INFO - Downloaded 10845952 bytes. 02:07:35 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:07:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:07:35 INFO - Return code: 0 02:07: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')]} 02:07:35 INFO - https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:07:37 INFO - Downloaded 58299726 bytes. 02:07:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:37 INFO - mkdir: /builds/slave/test/properties 02:07:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:07:37 INFO - Writing to file /builds/slave/test/properties/build_url 02:07:37 INFO - Contents: 02:07:37 INFO - build_url:https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 02:07:37 INFO - Running post-action listener: _resource_record_post_action 02:07:37 INFO - Running post-action listener: set_extra_try_arguments 02:07:37 INFO - ##### 02:07:37 INFO - ##### Running populate-webroot step. 02:07:37 INFO - ##### 02:07:37 INFO - Running pre-action listener: _resource_record_pre_action 02:07:37 INFO - Running main action method: populate_webroot 02:07:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:07:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:07:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:07:37 INFO - '--tppagecycles', 02:07:37 INFO - '7'], 02:07:37 INFO - 'tests': ['tsvgm']}}, 02:07:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:07:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:07:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:07:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:07:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:07:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['damp', 'tps']}, 02:07:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['damp', 'tps']}, 02:07:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['dromaeo_dom']}, 02:07:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:07:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['a11yr', 02:07:37 INFO - 'ts_paint', 02:07:37 INFO - 'tpaint', 02:07:37 INFO - 'sessionrestore', 02:07:37 INFO - 'sessionrestore_no_auto_restore', 02:07:37 INFO - 'tabpaint']}, 02:07:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tsvgx', 02:07:37 INFO - 'tsvgr_opacity', 02:07:37 INFO - 'tart', 02:07:37 INFO - 'tscrollx', 02:07:37 INFO - 'cart']}, 02:07:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:07:37 INFO - 'tsvgr_opacity', 02:07:37 INFO - 'tart', 02:07:37 INFO - 'tscrollx', 02:07:37 INFO - 'cart']}, 02:07:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s'], 02:07:37 INFO - 'tests': ['tp5o']}, 02:07:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'tests': ['tp5o']}, 02:07:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--disable-e10s', 02:07:37 INFO - '--xperf_path', 02:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:37 INFO - 'tests': ['tp5n']}, 02:07:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:07:37 INFO - 'talos_options': ['--xperf_path', 02:07:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:07:37 INFO - 'tests': ['tp5n']}}, 02:07:37 INFO - 'talos.zip': {'path': '', 02:07:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:07:37 INFO - Running post-action listener: _resource_record_post_action 02:07:37 INFO - ##### 02:07:37 INFO - ##### Running create-virtualenv step. 02:07:37 INFO - ##### 02:07:37 INFO - Running pre-action listener: _resource_record_pre_action 02:07:37 INFO - Running main action method: create_virtualenv 02:07:37 INFO - Creating virtualenv /builds/slave/test/build/venv 02:07:37 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:07:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:07:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:07:38 INFO - Using real prefix '/usr' 02:07:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:07:38 INFO - Installing distribute.............................................................................................................................................................................................done. 02:07:40 INFO - Installing pip.................done. 02:07:40 INFO - Return code: 0 02:07:40 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:07:40 INFO - Using env: {'DISPLAY': ':0', 02:07:40 INFO - 'HOME': '/home/cltbld', 02:07:40 INFO - 'LANG': 'en_US.UTF-8', 02:07:40 INFO - 'LANGUAGE': 'en_US:en', 02:07:40 INFO - 'LOGNAME': 'cltbld', 02:07:40 INFO - 'MAIL': '/var/mail/cltbld', 02:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:40 INFO - 'MOZ_NO_REMOTE': '1', 02:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:40 INFO - 'NO_EM_RESTART': '1', 02:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:40 INFO - 'PWD': '/builds/slave/test', 02:07:40 INFO - 'SHELL': '/bin/bash', 02:07:40 INFO - 'SHLVL': '1', 02:07:40 INFO - 'TERM': 'linux', 02:07:40 INFO - 'TMOUT': '86400', 02:07:40 INFO - 'USER': 'cltbld', 02:07:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:40 INFO - '_': '/tools/buildbot/bin/python'} 02:07:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:40 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:07:40 INFO - Cleaning up... 02:07:40 INFO - Return code: 0 02:07:40 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 02:07:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 02:07:40 INFO - Using env: {'DISPLAY': ':0', 02:07:40 INFO - 'HOME': '/home/cltbld', 02:07:40 INFO - 'LANG': 'en_US.UTF-8', 02:07:40 INFO - 'LANGUAGE': 'en_US:en', 02:07:40 INFO - 'LOGNAME': 'cltbld', 02:07:40 INFO - 'MAIL': '/var/mail/cltbld', 02:07:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:40 INFO - 'MOZ_NO_REMOTE': '1', 02:07:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:40 INFO - 'NO_EM_RESTART': '1', 02:07:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:40 INFO - 'PWD': '/builds/slave/test', 02:07:40 INFO - 'SHELL': '/bin/bash', 02:07:40 INFO - 'SHLVL': '1', 02:07:40 INFO - 'TERM': 'linux', 02:07:40 INFO - 'TMOUT': '86400', 02:07:40 INFO - 'USER': 'cltbld', 02:07:40 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:40 INFO - '_': '/tools/buildbot/bin/python'} 02:07:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:41 INFO - Downloading/unpacking psutil>=0.7.1 02:07:41 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 02:07:41 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 02:07:41 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 02:07:41 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 02:07:41 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 02:07:41 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 02:07:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:07:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:42 INFO - Installing collected packages: psutil 02:07:42 INFO - Running setup.py install for psutil 02:07:43 INFO - building 'psutil._psutil_linux' extension 02:07:43 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 02:07:43 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 02:07:43 INFO - building 'psutil._psutil_posix' extension 02:07:43 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 02:07:43 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 02:07:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:07:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:07:43 INFO - Successfully installed psutil 02:07:43 INFO - Cleaning up... 02:07:43 INFO - Return code: 0 02:07:43 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:43 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:43 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 02:07:43 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 02:07:43 INFO - Using env: {'DISPLAY': ':0', 02:07:43 INFO - 'HOME': '/home/cltbld', 02:07:43 INFO - 'LANG': 'en_US.UTF-8', 02:07:43 INFO - 'LANGUAGE': 'en_US:en', 02:07:43 INFO - 'LOGNAME': 'cltbld', 02:07:43 INFO - 'MAIL': '/var/mail/cltbld', 02:07:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:43 INFO - 'MOZ_NO_REMOTE': '1', 02:07:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:43 INFO - 'NO_EM_RESTART': '1', 02:07:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:43 INFO - 'PWD': '/builds/slave/test', 02:07:43 INFO - 'SHELL': '/bin/bash', 02:07:43 INFO - 'SHLVL': '1', 02:07:43 INFO - 'TERM': 'linux', 02:07:43 INFO - 'TMOUT': '86400', 02:07:43 INFO - 'USER': 'cltbld', 02:07:43 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:43 INFO - '_': '/tools/buildbot/bin/python'} 02:07:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:43 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:07:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:07:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:07:45 INFO - Installing collected packages: mozsystemmonitor 02:07:45 INFO - Running setup.py install for mozsystemmonitor 02:07:45 INFO - Successfully installed mozsystemmonitor 02:07:45 INFO - Cleaning up... 02:07:45 INFO - Return code: 0 02:07:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:07:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:07:45 INFO - Using env: {'DISPLAY': ':0', 02:07:45 INFO - 'HOME': '/home/cltbld', 02:07:45 INFO - 'LANG': 'en_US.UTF-8', 02:07:45 INFO - 'LANGUAGE': 'en_US:en', 02:07:45 INFO - 'LOGNAME': 'cltbld', 02:07:45 INFO - 'MAIL': '/var/mail/cltbld', 02:07:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:45 INFO - 'MOZ_NO_REMOTE': '1', 02:07:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:45 INFO - 'NO_EM_RESTART': '1', 02:07:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:45 INFO - 'PWD': '/builds/slave/test', 02:07:45 INFO - 'SHELL': '/bin/bash', 02:07:45 INFO - 'SHLVL': '1', 02:07:45 INFO - 'TERM': 'linux', 02:07:45 INFO - 'TMOUT': '86400', 02:07:45 INFO - 'USER': 'cltbld', 02:07:45 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:45 INFO - '_': '/tools/buildbot/bin/python'} 02:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:46 INFO - Downloading/unpacking blobuploader==1.2.4 02:07:46 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 02:07:46 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 02:07:46 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 02:07:46 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 02:07:46 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 02:07:46 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 02:07:47 INFO - Downloading blobuploader-1.2.4.tar.gz 02:07:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:07:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:07:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:48 INFO - Downloading docopt-0.6.1.tar.gz 02:07:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:07:48 INFO - Installing collected packages: blobuploader, requests, docopt 02:07:48 INFO - Running setup.py install for blobuploader 02:07:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:07:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:07:48 INFO - Running setup.py install for requests 02:07:49 INFO - Running setup.py install for docopt 02:07:49 INFO - Successfully installed blobuploader requests docopt 02:07:49 INFO - Cleaning up... 02:07:49 INFO - Return code: 0 02:07:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:49 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:49 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 02:07:49 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 02:07:49 INFO - Using env: {'DISPLAY': ':0', 02:07:49 INFO - 'HOME': '/home/cltbld', 02:07:49 INFO - 'LANG': 'en_US.UTF-8', 02:07:49 INFO - 'LANGUAGE': 'en_US:en', 02:07:49 INFO - 'LOGNAME': 'cltbld', 02:07:49 INFO - 'MAIL': '/var/mail/cltbld', 02:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:49 INFO - 'MOZ_NO_REMOTE': '1', 02:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:49 INFO - 'NO_EM_RESTART': '1', 02:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:49 INFO - 'PWD': '/builds/slave/test', 02:07:49 INFO - 'SHELL': '/bin/bash', 02:07:49 INFO - 'SHLVL': '1', 02:07:49 INFO - 'TERM': 'linux', 02:07:49 INFO - 'TMOUT': '86400', 02:07:49 INFO - 'USER': 'cltbld', 02:07:49 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:49 INFO - '_': '/tools/buildbot/bin/python'} 02:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:49 INFO - Running setup.py (path:/tmp/pip-W9n5kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:49 INFO - Running setup.py (path:/tmp/pip-c1eYaR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:49 INFO - Running setup.py (path:/tmp/pip-UG6mhk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:49 INFO - Running setup.py (path:/tmp/pip-Ei8o1K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:49 INFO - Running setup.py (path:/tmp/pip-MD60on-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:49 INFO - Running setup.py (path:/tmp/pip-hTxdL8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:49 INFO - Running setup.py (path:/tmp/pip-b6h7mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:49 INFO - Running setup.py (path:/tmp/pip-wFET_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:50 INFO - Running setup.py (path:/tmp/pip-7rNmvl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:50 INFO - Running setup.py (path:/tmp/pip-w7yCl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:50 INFO - Running setup.py (path:/tmp/pip-BNvwTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:50 INFO - Running setup.py (path:/tmp/pip-QkOFUh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:50 INFO - Running setup.py (path:/tmp/pip-EU4wg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:50 INFO - Running setup.py (path:/tmp/pip-ipenup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:50 INFO - Running setup.py (path:/tmp/pip-wc5SR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:50 INFO - Running setup.py (path:/tmp/pip-0ECt1r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:50 INFO - Running setup.py (path:/tmp/pip-T2EaLo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:07:50 INFO - Running setup.py install for manifestparser 02:07:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:07:50 INFO - Running setup.py install for mozcrash 02:07:50 INFO - Running setup.py install for mozdebug 02:07:50 INFO - Running setup.py install for mozdevice 02:07:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for mozfile 02:07:51 INFO - Running setup.py install for mozhttpd 02:07:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for mozinfo 02:07:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for mozInstall 02:07:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for mozleak 02:07:51 INFO - Running setup.py install for mozlog 02:07:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for moznetwork 02:07:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:07:51 INFO - Running setup.py install for mozprocess 02:07:51 INFO - Running setup.py install for mozprofile 02:07:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:07:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:07:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:07:52 INFO - Running setup.py install for mozrunner 02:07:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:07:52 INFO - Running setup.py install for mozscreenshot 02:07:52 INFO - Running setup.py install for moztest 02:07:52 INFO - Running setup.py install for mozversion 02:07:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:07:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:07:52 INFO - Cleaning up... 02:07:52 INFO - Return code: 0 02:07:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:52 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')]} 02:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:52 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')]} 02:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:52 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:52 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 02:07:52 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 02:07:52 INFO - Using env: {'DISPLAY': ':0', 02:07:52 INFO - 'HOME': '/home/cltbld', 02:07:52 INFO - 'LANG': 'en_US.UTF-8', 02:07:52 INFO - 'LANGUAGE': 'en_US:en', 02:07:52 INFO - 'LOGNAME': 'cltbld', 02:07:52 INFO - 'MAIL': '/var/mail/cltbld', 02:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:52 INFO - 'MOZ_NO_REMOTE': '1', 02:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:52 INFO - 'NO_EM_RESTART': '1', 02:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:52 INFO - 'PWD': '/builds/slave/test', 02:07:52 INFO - 'SHELL': '/bin/bash', 02:07:52 INFO - 'SHLVL': '1', 02:07:52 INFO - 'TERM': 'linux', 02:07:52 INFO - 'TMOUT': '86400', 02:07:52 INFO - 'USER': 'cltbld', 02:07:52 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:52 INFO - '_': '/tools/buildbot/bin/python'} 02:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:07:52 INFO - Running setup.py (path:/tmp/pip-V7mJDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:07:52 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)) 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:07:52 INFO - Running setup.py (path:/tmp/pip-OKdCQi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:07:52 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)) 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:07:52 INFO - Running setup.py (path:/tmp/pip-pAMD3B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:07:52 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)) 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:07:52 INFO - Running setup.py (path:/tmp/pip-LWJC2n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:07:52 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)) 02:07:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:07:52 INFO - Running setup.py (path:/tmp/pip-031XC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:07:53 INFO - Running setup.py (path:/tmp/pip-woT_ak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:07:53 INFO - Running setup.py (path:/tmp/pip-g5bnym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:07:53 INFO - Running setup.py (path:/tmp/pip-x0gTxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:07:53 INFO - Running setup.py (path:/tmp/pip-GTdNpj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:07:53 INFO - Running setup.py (path:/tmp/pip-LvtllA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:07:53 INFO - Running setup.py (path:/tmp/pip-fD_VsZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:07:53 INFO - Running setup.py (path:/tmp/pip-Djee6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:07:53 INFO - Running setup.py (path:/tmp/pip-n6Yzh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:07:53 INFO - Running setup.py (path:/tmp/pip-GtEmkN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:53 INFO - Running setup.py (path:/tmp/pip-3XGwYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:07:53 INFO - Running setup.py (path:/tmp/pip-51fLX3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:07:53 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)) 02:07:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:07:53 INFO - Running setup.py (path:/tmp/pip-64QhkR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:07:53 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)) 02:07:53 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)) 02:07:53 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)) 02:07:53 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)) 02:07:53 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)) 02:07:53 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)) 02:07:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:55 INFO - Downloading blessings-1.6.tar.gz 02:07:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:07:55 INFO - Installing collected packages: blessings 02:07:55 INFO - Running setup.py install for blessings 02:07:55 INFO - Successfully installed blessings 02:07:55 INFO - Cleaning up... 02:07:56 INFO - Return code: 0 02:07:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:07:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:07:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:07:56 INFO - Reading from file tmpfile_stdout 02:07:56 INFO - Current package versions: 02:07:56 INFO - argparse == 1.2.1 02:07:56 INFO - blessings == 1.6 02:07:56 INFO - blobuploader == 1.2.4 02:07:56 INFO - docopt == 0.6.1 02:07:56 INFO - manifestparser == 1.1 02:07:56 INFO - mozInstall == 1.12 02:07:56 INFO - mozcrash == 0.17 02:07:56 INFO - mozdebug == 0.1 02:07:56 INFO - mozdevice == 0.48 02:07:56 INFO - mozfile == 1.2 02:07:56 INFO - mozhttpd == 0.7 02:07:56 INFO - mozinfo == 0.9 02:07:56 INFO - mozleak == 0.1 02:07:56 INFO - mozlog == 3.1 02:07:56 INFO - moznetwork == 0.27 02:07:56 INFO - mozprocess == 0.22 02:07:56 INFO - mozprofile == 0.28 02:07:56 INFO - mozrunner == 6.11 02:07:56 INFO - mozscreenshot == 0.1 02:07:56 INFO - mozsystemmonitor == 0.0 02:07:56 INFO - moztest == 0.7 02:07:56 INFO - mozversion == 1.4 02:07:56 INFO - psutil == 3.1.1 02:07:56 INFO - requests == 1.2.3 02:07:56 INFO - wsgiref == 0.1.2 02:07:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:07:56 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')]} 02:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:56 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')]} 02:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:56 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:56 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 02:07:56 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 02:07:56 INFO - Using env: {'DISPLAY': ':0', 02:07:56 INFO - 'HOME': '/home/cltbld', 02:07:56 INFO - 'LANG': 'en_US.UTF-8', 02:07:56 INFO - 'LANGUAGE': 'en_US:en', 02:07:56 INFO - 'LOGNAME': 'cltbld', 02:07:56 INFO - 'MAIL': '/var/mail/cltbld', 02:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:56 INFO - 'MOZ_NO_REMOTE': '1', 02:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:56 INFO - 'NO_EM_RESTART': '1', 02:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:56 INFO - 'PWD': '/builds/slave/test', 02:07:56 INFO - 'SHELL': '/bin/bash', 02:07:56 INFO - 'SHLVL': '1', 02:07:56 INFO - 'TERM': 'linux', 02:07:56 INFO - 'TMOUT': '86400', 02:07:56 INFO - 'USER': 'cltbld', 02:07:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:56 INFO - '_': '/tools/buildbot/bin/python'} 02:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 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)) 02:07:56 INFO - Cleaning up... 02:07:56 INFO - Return code: 0 02:07:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:07:56 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')]} 02:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:56 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')]} 02:07:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:56 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:56 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 02:07:56 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 02:07:56 INFO - Using env: {'DISPLAY': ':0', 02:07:56 INFO - 'HOME': '/home/cltbld', 02:07:56 INFO - 'LANG': 'en_US.UTF-8', 02:07:56 INFO - 'LANGUAGE': 'en_US:en', 02:07:56 INFO - 'LOGNAME': 'cltbld', 02:07:56 INFO - 'MAIL': '/var/mail/cltbld', 02:07:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:56 INFO - 'MOZ_NO_REMOTE': '1', 02:07:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:56 INFO - 'NO_EM_RESTART': '1', 02:07:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:56 INFO - 'PWD': '/builds/slave/test', 02:07:56 INFO - 'SHELL': '/bin/bash', 02:07:56 INFO - 'SHLVL': '1', 02:07:56 INFO - 'TERM': 'linux', 02:07:56 INFO - 'TMOUT': '86400', 02:07:56 INFO - 'USER': 'cltbld', 02:07:56 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:56 INFO - '_': '/tools/buildbot/bin/python'} 02:07:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:56 INFO - Downloading/unpacking jsonschema 02:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:07:58 INFO - Downloading/unpacking functools32 (from jsonschema) 02:07:58 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 02:07:58 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 02:07:58 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 02:07:58 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 02:07:58 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 02:07:58 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 02:07:58 INFO - Downloading functools32-3.2.3-2.tar.gz 02:07:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:07:58 INFO - warning: no files found matching '*.txt' 02:07:58 INFO - no previously-included directories found matching 'build' 02:07:58 INFO - no previously-included directories found matching 'dist' 02:07:58 INFO - no previously-included directories found matching '.git*' 02:07:58 INFO - Installing collected packages: jsonschema, functools32 02:07:58 INFO - Running setup.py install for functools32 02:07:58 INFO - warning: no files found matching '*.txt' 02:07:58 INFO - no previously-included directories found matching 'build' 02:07:58 INFO - no previously-included directories found matching 'dist' 02:07:58 INFO - no previously-included directories found matching '.git*' 02:07:58 INFO - Successfully installed jsonschema functools32 02:07:58 INFO - Cleaning up... 02:07:59 INFO - Return code: 0 02:07:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:07:59 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')]} 02:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:07:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:59 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')]} 02:07:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:07:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:07:59 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 0x7f34f656af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x209d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x21689a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, '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': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', '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 02:07:59 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 02:07:59 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 02:07:59 INFO - Using env: {'DISPLAY': ':0', 02:07:59 INFO - 'HOME': '/home/cltbld', 02:07:59 INFO - 'LANG': 'en_US.UTF-8', 02:07:59 INFO - 'LANGUAGE': 'en_US:en', 02:07:59 INFO - 'LOGNAME': 'cltbld', 02:07:59 INFO - 'MAIL': '/var/mail/cltbld', 02:07:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:07:59 INFO - 'MOZ_NO_REMOTE': '1', 02:07:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:07:59 INFO - 'NO_EM_RESTART': '1', 02:07:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:07:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:07:59 INFO - 'PWD': '/builds/slave/test', 02:07:59 INFO - 'SHELL': '/bin/bash', 02:07:59 INFO - 'SHLVL': '1', 02:07:59 INFO - 'TERM': 'linux', 02:07:59 INFO - 'TMOUT': '86400', 02:07:59 INFO - 'USER': 'cltbld', 02:07:59 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:07:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:07:59 INFO - '_': '/tools/buildbot/bin/python'} 02:07:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:07:59 INFO - Downloading/unpacking flake8 02:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:07:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:07:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:08:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:08:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:08:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 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 02:08:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:01 INFO - no previously-included directories found matching 'docs/_build' 02:08:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:08:01 INFO - Running setup.py install for pep8 02:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:08:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:08:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:08:01 INFO - no previously-included directories found matching 'docs/_build' 02:08:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:08:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:08:02 INFO - Cleaning up... 02:08:02 INFO - Return code: 0 02:08:02 INFO - Running post-action listener: _resource_record_post_action 02:08:02 INFO - Running post-action listener: _start_resource_monitoring 02:08:02 INFO - Starting resource monitoring. 02:08:02 INFO - ##### 02:08:02 INFO - ##### Running install step. 02:08:02 INFO - ##### 02:08:02 INFO - Running pre-action listener: _resource_record_pre_action 02:08:02 INFO - Running main action method: install 02:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:08:02 INFO - Reading from file tmpfile_stdout 02:08:02 INFO - Detecting whether we're running mozinstall >=1.0... 02:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:08:02 INFO - Reading from file tmpfile_stdout 02:08:02 INFO - Output received: 02:08:02 INFO - Usage: mozinstall [options] installer 02:08:02 INFO - Options: 02:08:02 INFO - -h, --help show this help message and exit 02:08:02 INFO - -d DEST, --destination=DEST 02:08:02 INFO - Directory to install application into. [default: 02:08:02 INFO - "/builds/slave/test"] 02:08:02 INFO - --app=APP Application being installed. [default: firefox] 02:08:02 INFO - mkdir: /builds/slave/test/build/application 02:08:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:08:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:08:18 INFO - Reading from file tmpfile_stdout 02:08:18 INFO - Output received: 02:08:18 INFO - /builds/slave/test/build/application/firefox/firefox 02:08:18 INFO - Running post-action listener: _resource_record_post_action 02:08:18 INFO - ##### 02:08:18 INFO - ##### Running run-tests step. 02:08:18 INFO - ##### 02:08:18 INFO - Running pre-action listener: _resource_record_pre_action 02:08:18 INFO - Running main action method: run_tests 02:08:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:08:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:08:18 INFO - Python 2.7.3 02:08:18 INFO - Return code: 0 02:08:18 INFO - grabbing minidump binary from tooltool 02:08: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')]} 02:08:18 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 0x21f7810>, '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 0x21f8710>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21f8ba0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:08:18 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 02:08:18 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 02:08:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:08:19 INFO - Return code: 0 02:08:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:08:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:08:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:08:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:08:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:08:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:08:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:08:20 INFO - Return code: 0 02:08:20 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/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:08:20 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/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --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 02:08:20 INFO - Using env: {'DISPLAY': ':0', 02:08:20 INFO - 'HOME': '/home/cltbld', 02:08:20 INFO - 'LANG': 'en_US.UTF-8', 02:08:20 INFO - 'LANGUAGE': 'en_US:en', 02:08:20 INFO - 'LOGNAME': 'cltbld', 02:08:20 INFO - 'MAIL': '/var/mail/cltbld', 02:08:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:08:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:08:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:08:20 INFO - 'MOZ_NO_REMOTE': '1', 02:08:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:08:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:08:20 INFO - 'NO_EM_RESTART': '1', 02:08:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:08:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:08:20 INFO - 'PWD': '/builds/slave/test', 02:08:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:08:20 INFO - 'SHELL': '/bin/bash', 02:08:20 INFO - 'SHLVL': '1', 02:08:20 INFO - 'TERM': 'linux', 02:08:20 INFO - 'TMOUT': '86400', 02:08:20 INFO - 'USER': 'cltbld', 02:08:20 INFO - 'XDG_SESSION_COOKIE': '78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410', 02:08:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:08:20 INFO - '_': '/tools/buildbot/bin/python'} 02:08:20 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/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--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 02:08:20 INFO - mozversion application_buildid: 20160419233021 02:08:20 INFO - mozversion application_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 02:08:20 INFO - mozversion application_display_name: Nightly 02:08:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:08:20 INFO - mozversion application_name: Firefox 02:08:20 INFO - mozversion application_remotingname: firefox 02:08:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:08:20 INFO - mozversion application_vendor: Mozilla 02:08:20 INFO - mozversion application_version: 48.0a1 02:08:20 INFO - mozversion platform_buildid: 20160419233021 02:08:20 INFO - mozversion platform_changeset: 973dfa15822126c39ea2d98d34ac16643b040243 02:08:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:08:20 INFO - mozversion platform_version: 48.0a1 02:08:20 INFO - using testdate: 1461143300 02:08:20 INFO - actual date: 1461143300 02:08:20 INFO - starting webserver on 'localhost:58856' 02:08:20 INFO - SUITE-START | Running 2 tests 02:08:20 INFO - TEST-START | dromaeo_css 02:08:20 INFO - operating with platform_type : linux_ 02:08:20 INFO - Initialising browser for dromaeo_css test... 02:08:20 INFO - TEST-INFO | started process 27195 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcACNfV/profile http://localhost:58856/getInfo.html) 02:08:24 INFO - PROCESS | 27195 | __metrics Screen width/height:1600/1200 02:08:24 INFO - PROCESS | 27195 | colorDepth:24 02:08:24 INFO - PROCESS | 27195 | Browser inner width/height: 1024/697 02:08:24 INFO - PROCESS | 27195 | __metrics 02:08:25 ERROR - PROCESS | 27195 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:08:26 INFO - TEST-INFO | 27195: exit 0 02:08:26 INFO - Browser initialized. 02:08:26 INFO - Running cycle 1/1 for dromaeo_css test... 02:08:26 INFO - TEST-INFO | started process 27277 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcACNfV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:08:38 INFO - PROCESS | 27277 | RSS: Main: 153677824 02:08:38 INFO - PROCESS | 27277 | 02:09:29 INFO - PROCESS | 27277 | 1461143369257 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] 02:11:36 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58856/tests/dromaeo/cssquery-ext.html) 02:11:37 INFO - PROCESS | 27277 | RSS: Main: 259207168 02:11:37 INFO - PROCESS | 27277 | 02:14:40 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-ext.html (next: http://localhost:58856/tests/dromaeo/cssquery-jquery.html) 02:14:40 INFO - PROCESS | 27277 | RSS: Main: 231317504 02:14:40 INFO - PROCESS | 27277 | 02:17:42 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58856/tests/dromaeo/cssquery-mootools.html) 02:17:43 INFO - PROCESS | 27277 | RSS: Main: 237248512 02:17:43 INFO - PROCESS | 27277 | 02:20:45 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58856/tests/dromaeo/cssquery-prototype.html) 02:20:45 INFO - PROCESS | 27277 | RSS: Main: 236625920 02:20:45 INFO - PROCESS | 27277 | 02:23:48 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58856/tests/dromaeo/cssquery-yui.html) 02:23:48 INFO - PROCESS | 27277 | RSS: Main: 223580160 02:23:48 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | Cycle 1(1): loaded http://localhost:58856/tests/dromaeo/cssquery-yui.html (next: http://localhost:58856/tests/dromaeo/cssquery-dojo.html) 02:26:51 INFO - PROCESS | 27277 | RSS: Main: 258539520 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | __start_tp_report 02:26:51 INFO - PROCESS | 27277 | _x_x_mozilla_page_load 02:26:51 INFO - PROCESS | 27277 | _x_x_mozilla_page_load_details 02:26:51 INFO - PROCESS | 27277 | |i|pagename|runs| 02:26:51 INFO - PROCESS | 27277 | |0;dojo.html;3060.678628743982;3095.1643056374764;3132.060381885434;3140.3405284890173;3172.524121381793;5296.152615581508;5311.389190243123;5318.388385335683;5377;5392.0294347017525;5409.6213265071465;5457.290552228214;5490.505854473096;5505.559555235582;5546.417626149247;4836.105320515716;4840.612750979931;4857.708537487762;4882.487338829425;4948.876278093058;4858.927116093261;4893.804247830082;4907.730074845882;4916.139675556781;4928.507149285078;4827.855164345057;4834.468208497063;4872;4874.8537543873745;4878.024395120972;4860.562549370538;4863.756812159378;4881.292212629184;4896.2410826321975;4898.118338699032;4810.39870016248;4852.878678033042;4861.82983595576;4872.6832755870755;4899.387576552931;5239.056969745444;5239.79040838366;5245.291885595434;5268.1834315681135;5310.70791106489;5623.831285061455;5633.492985631272;5634.04221282383;5660.660360378391;5662.348829884575;5608.803691870765;5674.687892165929;5678.063119585264;5718.056520674084;5726.5705072119345;5363.597730170214;5383.67697938125;5387.622866399353;5388.973055134738;5435.374931882845;5865.765369385262;5885.793997210077;5886.58793884424;5890.410958904161;5896.086106653475;5460.180972854024;5630.296212973379;5654.151877218368;5701.258836351248;5742.167385729046;5724.370319264877;5739.569532285095;5747.597668163272;5748.741306641211;5751.913721294184;5705.600607957404;5708.65748055118;5719.456651618089;5722.399148089474;5724.79963201286;5674.205611214434;5692.459216374438;5746.310442746897;5767.336756273083;5793.333766616893;4373.803178856959;4385.166818304512;4387.078713470143;4392.538783427758;4429.379886815848;3866.574676785551;3891.8443262269757;3924.1955399143108;3935.35066713989;3946.131850992777;5344.508002311966;5399.595030372738;5444.1017232156255;5491.258680078138;5492.231087647732;5683.54531637468;5685.886282274331;5693.089105743061;5694.772209111589;5697.430256974352;5376.596755243372;5402.18967154922;5419.403865574784;5449.128139497661;5481.287432633732;4969.850904472872;4987.501249874984;4992.450830408652;4993.400791904995;5033.974830125826;5976.73104710289;6002.69986500682;6003.249593800775;6005;6007.759689612454;5692.288463942007;5708.315002199596;5767.307923049177;5782.2194003808945;5789.91315130265;6010.459058684739;6016.63900165974;6019.969900150471;6020.668863212565;6053.788117416046;5707.172459993195;5708.315002199763;5712.428757124254;5717.285339332583;5728.198052272602;5491.450854914477;5770.884582308414;5775.768969241183;5814.563907707024;5859.267591551056;5610.9158362623775;5627.662340259598;5642.71786410686;5647.887042259214;5652.0674088774895;5577.888442231051;5604.271444712162;5623.493885550321;5632.352279487911;5638.859028524155;5463.863403414946;5508.862278442911;5557;5557.388687244481;5606.131049687305;5595.944040559542;5596.916046259391;5611.130274807411;5619.803306884403;5628.212050312877;5438.510534051954;5491.203775452617;5496.560275178056;5504.724763761716;5542.11326187808 02:26:51 INFO - PROCESS | 27277 | |1;ext.html;601.7081715368046;606.0969155957623;649.6654223075114;657.8092353217567;661.4245606322497;31300.217494562618;32094.35811283773;32147.19632009201;32190.35619287613;34621;38810;39148.41277380841;39182.80408597953;39242.21515569687;39368.409473857915;8242.546659933701;8397.118302578234;8437.493750374997;8456.365772567051;8524.360672949522;8173.79565510864;8251.834963300731;8371.414001019932;8500.362472814533;8518.318534517255;8359.83280334393;8405.41162118652;8444.61999210037;8574.056853746082;8750.299976001905;8567.571621418936;8628.568571571459;8634.913650863473;8637.697680581212;8641.265492433151;8645.783855403603;8649.481031138152;8760.780980475476;8781.517016564087;8827.558622068935;37143.4428483573;37499.62500374988;37653.05867353311;37661.43507847384;37865.43201851974;3187.5218717192374;3300.3894279558117;3351.7151042161445;3702.9629703702885;3997.180577981536;27978.72021279802;28718.71281287202;28993.56509652357;29298.267543311376;29455.11634650964;3959.109200429909;3975.605145603067;4129.710920235585;4141.875743727693;4184.4351012613215;294503;296439;296748;297562;297692;41484.58515414868;42985.35521967173;43012.62342207224;52152.478475215525;55908;40512.59487405147;40516.18967620631;40527.59472405297;40624.18751624951;40659;16241.51275461738;16479;16509.33962641481;16535.25591348392;16547;11623.360715160747;12253.142280040312;12605.558805441766;12732.427040783186;12771.872281277254;12392.81410778839;12477.563285284972;12480.625581232578;12498.437570309357;12627.87372126267;6261.24865016201;6372.4583410409705;6396.84007899797;6525.738970441224;6546.574472659262;979.8481235408523;1037.227265687068;1049.4333060147435;1082.2910993299402;1152.9365884876413;30300.54549181764;30705.539416908763;30838.845805770827;31726.682733172835;31767;1099.9450027498592;1130.4404319861558;1136.5226604825993;1136.5624234669713;1197.760447910404;15790.526284211492;16557.25492352847;16933.915330423515;17097.48707538776;17386;421157;609458;633575;635423;637174;51991.74004129955;52676.73661631744;52774.73612631912;54641.726791365785;54660.18009729857;1235.4193529041336;1267.0623738433492;1295.4947570447532;1330.9866901330863;1446.900355729632;26113.086041988438;27356.358618482955;27669.308267292672;28167;28174.71825281721;40308.59691403049;40567.79716101401;40601.59398405978;40891;41198.38202426906;223262;224175;224233;224301;224966;23152.76847231506;25073.373165671004;25490.23529294124;25787.355316117246;26187.73812261853;33163.83418082894;33199.502007469426;37754.05614859541;38606;39768.20463590654;30015.249618758833;30291.242718932204;30389.392212156075;30824;31253.843730781202;29683.257918552208;29754.40491190121;30103;30166.69833301639;30196.849015754782;35400.64599354076;37051;37294.62705372911;37413.064673383386;39389.6061039386;28223.294417639725;28952.276193094498;30005.699943001164;30411.54382684217;31180.247554142607;27244.318892027066;27725;27944.30139246535;28015;28034.439311214068 02:26:51 INFO - PROCESS | 27277 | |2;jquery.html;380.16933001391976;389.42754151397446;391.80018190722734;396.96427321541057;398.08440586650715;16301.266443010063;17860.821391786078;18483.353082642112;18497.537561560934;18502.537436564093;17057.061861597605;17066.658666826657;17169.399071032516;17258.82741172588;18894.527636809085;5588.273524441827;5776.740046697888;5806.65160090396;5825.825225243249;5828.883422331551;5166;5467.972660136694;5468.425815289397;5481.506664400204;5483.177523371486;5438.619296649236;5449.591280653947;5624.3250809902665;6088.0259158534645;6088.543359248052;6036.5170786336985;6042.879142417149;6065.090236464522;6087.78692745754;6091.0558863376245;4762.666613337068;5073.315102461157;5078.695278283315;5081.339425874649;5082.440931497532;12771.61685149447;13063.216207027514;17994.37019704304;19068.618627627508;20122.195112195495;2056.979430205694;2153.1172219390132;2178.270279456384;2231.4421394651336;2243.7868402501736;9421.670241541513;9896.455694936776;9983.75040623983;10026.649067282682;10272.948635256851;1821.298799962024;1951.9414417567496;1960.5490737130397;1988.8607797454183;1999;80245.59877200636;82365.93974662782;82570.58714706448;83889;83928;10530.473476326153;10541.578336866593;10685.78628427427;10870.72823179411;10937.781244375068;15092.924535377253;15166.393344266105;15171.696566068616;15191.848081519043;15216.619584510476;7675.961620191863;7680.231976802387;7815.960920195476;7824.882626760603;8125.593720313961;7480.5885676287235;7581.3176814087;7641.503302285334;7825.13923468418;7850.175731548219;4492.550744925481;4545.227311357077;4586.518415566385;4598.97700511502;4631.745254011062;1702.3105642214923;1726.8791184616957;1740.1386313774763;1750.431109889291;1874.9437516874243;899.7263000746455;972.9783727086531;983.0660872171466;1019.2661283875598;1034.6171916390983;15638.9218053909;15942.442014529435;16941.06824124685;16993.235304411082;17248.655026899392;994.3487016004528;1005.1556692378438;1043.1654676258963;1067.9305845120198;1081.9891801082047;9529.857052144223;10365.896341036643;10604.310719803188;10658.73353166177;10819.513121909376;485311;491612;498223;498998;509190;64205;79805.60097199476;80984;89216.5539172313;90012;996.5017491254373;1010.8483727440943;1023.6928921323722;1033.390299723167;1041.5313109100935;16684.249208785877;16992.320307188067;17195.22621482011;17221.655566888843;17347.826521735125;36766.81616592007;37936.43095353627;38854.805725971186;38915.2216955665;39598;51339;55235.723821380634;55360.72319638376;55544.16683749828;55630.72184639051;7998.600069996593;8177.877331839908;8194.754157375288;8202.138775428493;8274.379421543528;9086.54567271647;11108.889111088827;11291.322520648788;12362.134650574373;12476.812847807472;10617.946910265398;11069.169812263952;11738.88261117412;11780.05759539252;11791.29252244868;8737;10728.302660327054;11086.722831929266;11563.942180289381;11932.522699091938;11271;11593.956543911088;11652.359120248468;11827.645170644895;11888.940555297168;7346.228645992308;7664.80837979055;8334.374921880762;8559.57202139878;8573.485590864568;10488;10673.626423075155;10684.145268378667;10700.785984280115;10787.190960677824 02:26:51 INFO - PROCESS | 27277 | |3;mootools.html;1188.4354931407577;1458.445790599572;1514.6364872430615;1621.3028397788946;1786.472990467811;7441.144268409128;8417.537035463047;8616.65533378664;8619.267362274206;8623.784405389868;8325.084240733515;8500.447470914387;8504.787380315494;8507.744767656965;8522.977242730882;2013.6878783788463;2057.351934140748;2059.8455115866295;2302.666113413554;2335.8948847301913;2281.634938409855;2357.3281614739803;2361.8700971446565;2365;2365.5387199496104;2293.2776175504664;2303.49323148907;2311.9884400577976;2314.618088015475;2328.9184878529254;2021.353166986565;2086.9478263043393;2235.0724449353497;2239.8656080635214;2242.2600541821243;1984.9106790194476;2187.628103222456;2249.5725812095648;2251.639737641986;2255.785700358463;8122.553259570721;8160.877586836202;8186.386021048445;8188.426810123294;8195;4923.630727695438;5020.523050310215;5028.823991160292;5063.8987220255385;5076.492350764931;3084.8457577121053;3089.5365695145683;3130.937381252385;3161.2413020874824;3222.91942701432;1013.9036791504795;1015.720676813882;1027.8539428537201;1044.843273508972;1066.8933106689346;11690.707732306675;11690.941545292304;11723.589674361356;11726.35505047222;11747.471363788565;4416.558344165622;4436.556344365602;4634.397528321297;4636.4899861015265;4644.535546445396;9753;9779.31544791872;9780.315377923476;9790.21678265737;9793.461359625146;5022.949770502321;5072.873178170502;5073.441921388644;5092.0579692756955;5106.591472682177;4212.578742125763;4629.282461218517;4676.672632915664;4759.0719809636785;4767.237242041257;3701.481792549045;3741.513603231617;3748.0442487165597;3771.30230907283;3814.1227517670536;1241.1932244041445;1256.7298030923396;1258.9550672941436;1263.988808952834;1267.8922291605131;731.4550659758407;879.2745984562762;917.3761841947539;930.2697382554662;939.7603611079131;5706.400827913092;5812.505936995318;5818.709064546756;5847.210626565359;5901.17383566301;900.1538553759445;905.6513242401722;926.8285367207088;938.1931538876561;948.1608776233084;3812.8284227209842;3894.3184942634925;3969.54350249725;4006.3790112532606;4046.8785936421364;10542.894571054192;10767.19246056549;10919.890801092046;10988.890111098946;11054.557817687202;10902.67291981226;10909.290896091728;10910.181736369805;10926.235163538477;10926.617568385069;7888.290053895177;7917.208279172037;8088.393370497236;8122.634481448349;8131.390145738975;5711;5782.074868021096;5824;5888.234529511307;5909.55678324136;10057.094861462503;10067.1442927352;10082.747931301776;10105.141063009727;10109.747256318651;10074.597016119273;10085.949570252102;10181.592736290762;10182.694519164437;10362.740931476774;6538.8365290868105;6913.965430172817;6972.511924165463;7097.361237488651;7293.452991025588;8004.399670024655;8053.6778528858185;8105.148959359182;8109.189081091844;8113.6754529818145;7170.211276759656;7509.324160825552;7569.47013709035;7656.349210317186;7666.578338191453;7293.744718934812;7330.266973302627;7347.7795666130105;7375.041244638162;7444.255574442513;6762.053312536151;6822.215445223665;6835.282295358916;6839.110915580943;6846.931530684629;4745.9686656506965;4925.605951523798;4971.154903666313;5024.698518088926;5026.723530205728;4811.470738218723;5042.596592272536;5048.167052436307;5160.587153027824;5171.3535808024 02:26:51 INFO - PROCESS | 27277 | |4;prototype.html;332.5169742946459;336.8955623756636;337.9425497665397;344.03669724770634;347.0923534956091;5488;5546.722663866811;5555.333359996801;5605.355384130826;5640.774369025245;5502.697351645658;5520.558355331574;5563.693996830173;5565.6660600364;5568.136938774496;4134.483189601292;4171.270027745148;4297.677674174433;4311.439512863323;4323;4319.157764235975;4327.031200803627;4337.568602361229;4344.761038142901;4356.433663623725;4152.397902304164;4297.828086876537;4298.161858437606;4300.440942677447;4328.805203765838;4171.916561668765;4259.488861336644;4295.613394794484;4302.612764851178;4315.784210789448;3803.695704343646;3804.90487737806;3808.1622043150464;3813.637704418076;3817.3319669057805;5251.448597897204;5428.9185662215095;5446.128619420873;5449.346078470569;5450.836474905759;4924.950750492485;4945.530174633404;4952.083864485082;4960.776765045582;4975.427825800007;5767.452092051249;5769.596128271022;5785.82642520725;5830.562707796932;5841.123831425278;4085.9591404085877;4184.28867092595;4184.8744537663915;4188.193910080254;4194.077302993367;6055.636661800306;6055.6677530943125;6079.39206079393;6086.360932102154;6095.878082438371;4268.615824575803;4274.734390772833;4276.5723427656985;4278.978605106954;4303.913921721548;4274.422952901318;4295.52749197588;4346.195953748504;4349.086691794759;4351.782410879443;4912.631552633567;4933;4955.472708918477;4957.132501812169;4960.603151747851;5812.622179558315;5848.181254624356;5863.706814659336;5864.44287792659;5880.852978675567;1486.539172856418;1497.2663394936621;1512.1683074309085;1512.7125846089207;1518.089146512106;966.7389804752678;1026.1534234256767;1035.404642330663;1045.4981608827804;1054.4253381906879;5575.526080283222;5643.294588176478;5646.943530564724;5671.971640141773;5676.4323567642905;5909.674967876808;5924.170616113747;5985.042393217064;6014.368491308437;6015.526196081988;5463.180522921593;5696.8860622787315;5771.740271687784;5776.624519406225;5824.446677565625;3244.1565193049505;3250.8049517029053;3257.250832308582;3265.461198902202;3275.6078666566614;6202.751889924352;6328.71520781566;6352.428281454691;6353.714082866282;6370.936290637127;6249.187605611241;6262.530310226751;6265.404786545271;6268.717907694074;6270.648506809946;6047.455728984237;6252.093446450239;6260.217472815989;6261.279952805395;6276.937230627726;6045.57680962346;6071.726772295346;6077.726502307495;6084.209052823105;6091.543134264859;5970.701464926823;5992.310884248367;6000.429959153874;6002.969985150046;6036.0644100164545;6096.786612468542;6270.15352927349;6310.905336419865;6311.810645680637;6318.715657795502;4188.706790524634;4208.621224089847;4233.259179643612;4242.851500197478;4247.532771395206;5988.586505691714;6079.878402432015;6109.2974307955155;6122.4795892347865;6129;5912.438318359921;5913.231279933581;5918.112283157388;5930.28836539618;5932.436418540232;5855.619384739978;5857.765689372377;5862.501687356623;5867.501262392574;5876.265466816648;5375.462453754593;5655.802046928337;5782.074868021265;5784.132380143013;5787.652740835563;5905.852353691021;5912.290525137011;5932.436418540232;5940.405959404025;5946.07835785454;5640.85897852557;5813.3605303417435;5828.921649494857;5841.240638716939;5853.239078919713 02:26:51 INFO - PROCESS | 27277 | |5;yui.html;750.197288900876;754.1252147508889;761.5811303782915;779.4115442840655;782.2685788787487;13839.377228024738;14026.088304260216;14069.366878490468;14086.929565352171;14770.852291477082;13411.59765207043;13425.597232083028;13504.932475337635;13533.526326578572;13594.660133496667;641.2593454559991;791.9287264146226;805.4965646470955;806.701520437436;825.6119623776815;814.5275740070745;815.2255357410454;816.828466022136;817.382875928673;817.4686453805015;854.1245223645751;857.7383897911135;859.5702148925537;859.8581234096366;859.9011113721908;708.2810946888886;721.4372789224414;722.0613202836319;813.8209593889394;847.7329641163014;627.0813258576162;627.9780207692709;628.0892705576886;628.3308276685316;629.0815409502133;14194.787078193835;14377.56867293983;14432.855671443256;14469.638259043502;14564.92717536416;14088.718225635532;14198;14246.715065698629;14427.567172984722;14525.12849229039;11682.12384071198;11827.172097953147;11833.290002599786;11911.583094591648;12142.210756300901;3687.723420743455;3748.231612519427;3768.133329334241;3885.26180025797;3912.256671232457;60903.999999999556;61078.694606527126;61341;61417.69291153516;61582.38417615811;10863.565457381774;10864.837027444595;10887.618933337295;10969;11056.391898445501;21113.78886211149;21127.8943605281;21143.365699029055;21184.682229766568;21188.9405529726;7970.402219833536;8126;8164.7958801030445;8284.875726864102;8464.32285417165;4285.5928686774705;4439.66702497314;4463.196624607537;4513.277875539898;4591.288350305708;3230.5315729219133;3331.68349006844;3332.6500717424806;3334.516140317584;3337.1490269981;560.6355868685387;596.1445325957266;598.1894532907847;603.4026313949158;605.352273067822;639.763287583597;709.2871663977669;721.4264659595634;753.0962844586518;766.7623036858591;8702.869456958151;8904.184312053136;8969.282457403391;8995.415298005608;9140.268778497704;705.386313906894;707.3280383635566;713.7608901018217;720.8486217894301;732.1872721279376;4009.426955944843;4115.8765237042935;4256.6807489438415;4339.73961562301;4381.079973205662;62750.686246569385;64301.35698643047;65517.34482655208;65758.34241657522;66107;55776.442235577124;55897.44102559004;56626.150607740914;56733.432665672815;56787.43212567904;50833.23750143751;51025.489745102816;51495.48504514907;52045.7397713009;52110;7864.72473463426;7905.802354940943;8148.144444833444;8431.325493960347;8469.068402475847;31979.200519987186;32152.356952860344;32340.191495212806;33994;34026.14934626555;39441.40837887376;41592.792036039624;45147;46008.53991460043;46227;11288.586859044437;11377.829332559853;11543.942280288546;11618.302901825917;11997.940010299893;12180.086493512845;12351.135420520477;12457.439415226518;13001.219926804422;13004.934975325063;11827.349495777471;11894.286342819458;12019.75960480803;12140.817887731515;12498.25010499373;10640.467976601294;10810.783784324427;10908.672739817817;11143.387113708499;11338.14963877729;11168.944155279172;11357.318560886373;11914.880851191378;12070.215435996632;12675.239485630524;10149.949250253701;10200.489975501343;10611.204159688208;10644;10681.89318106809;10802.67591972242;10818.51316690735;10867.260337386972;10946.671599852018;11081.889181108085 02:26:51 INFO - PROCESS | 27277 | __end_tp_report 02:26:51 INFO - PROCESS | 27277 | __start_cc_report 02:26:51 INFO - PROCESS | 27277 | _x_x_mozilla_cycle_collect,835 02:26:51 INFO - PROCESS | 27277 | __end_cc_report 02:26:51 INFO - PROCESS | 27277 | __startTimestamp1461144411482__endTimestamp 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | ------- Summary: start ------- 02:26:51 INFO - PROCESS | 27277 | Number of tests: 6 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#0] dojo.html Cycles:165 Average:5332.76 Median:5542.11 stddev:605.10 (10.9%) stddev-sans-first:580.11 02:26:51 INFO - PROCESS | 27277 | Values: 3060.7 3095.2 3132.1 3140.3 3172.5 5296.2 5311.4 5318.4 5377.0 5392.0 5409.6 5457.3 5490.5 5505.6 5546.4 4836.1 4840.6 4857.7 4882.5 4948.9 4858.9 4893.8 4907.7 4916.1 4928.5 4827.9 4834.5 4872.0 4874.9 4878.0 4860.6 4863.8 4881.3 4896.2 4898.1 4810.4 4852.9 4861.8 4872.7 4899.4 5239.1 5239.8 5245.3 5268.2 5310.7 5623.8 5633.5 5634.0 5660.7 5662.3 5608.8 5674.7 5678.1 5718.1 5726.6 5363.6 5383.7 5387.6 5389.0 5435.4 5865.8 5885.8 5886.6 5890.4 5896.1 5460.2 5630.3 5654.2 5701.3 5742.2 5724.4 5739.6 5747.6 5748.7 5751.9 5705.6 5708.7 5719.5 5722.4 5724.8 5674.2 5692.5 5746.3 5767.3 5793.3 4373.8 4385.2 4387.1 4392.5 4429.4 3866.6 3891.8 3924.2 3935.4 3946.1 5344.5 5399.6 5444.1 5491.3 5492.2 5683.5 5685.9 5693.1 5694.8 5697.4 5376.6 5402.2 5419.4 5449.1 5481.3 4969.9 4987.5 4992.5 4993.4 5034.0 5976.7 6002.7 6003.2 6005.0 6007.8 5692.3 5708.3 5767.3 5782.2 5789.9 6010.5 6016.6 6020.0 6020.7 6053.8 5707.2 5708.3 5712.4 5717.3 5728.2 5491.5 5770.9 5775.8 5814.6 5859.3 5610.9 5627.7 5642.7 5647.9 5652.1 5577.9 5604.3 5623.5 5632.4 5638.9 5463.9 5508.9 5557.0 5557.4 5606.1 5595.9 5596.9 5611.1 5619.8 5628.2 5438.5 5491.2 5496.6 5504.7 5542.1 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#1] ext.html Cycles:180 Average:50623.41 Median:33181.67 stddev:108453.28 (326.8%) stddev-sans-first:108692.50 02:26:51 INFO - PROCESS | 27277 | Values: 601.7 606.1 649.7 657.8 661.4 31300.2 32094.4 32147.2 32190.4 34621.0 38810.0 39148.4 39182.8 39242.2 39368.4 8242.5 8397.1 8437.5 8456.4 8524.4 8173.8 8251.8 8371.4 8500.4 8518.3 8359.8 8405.4 8444.6 8574.1 8750.3 8567.6 8628.6 8634.9 8637.7 8641.3 8645.8 8649.5 8760.8 8781.5 8827.6 37143.4 37499.6 37653.1 37661.4 37865.4 3187.5 3300.4 3351.7 3703.0 3997.2 27978.7 28718.7 28993.6 29298.3 29455.1 3959.1 3975.6 4129.7 4141.9 4184.4 294503.0 296439.0 296748.0 297562.0 297692.0 41484.6 42985.4 43012.6 52152.5 55908.0 40512.6 40516.2 40527.6 40624.2 40659.0 16241.5 16479.0 16509.3 16535.3 16547.0 11623.4 12253.1 12605.6 12732.4 12771.9 12392.8 12477.6 12480.6 12498.4 12627.9 6261.2 6372.5 6396.8 6525.7 6546.6 979.8 1037.2 1049.4 1082.3 1152.9 30300.5 30705.5 30838.8 31726.7 31767.0 1099.9 1130.4 1136.5 1136.6 1197.8 15790.5 16557.3 16933.9 17097.5 17386.0 421157.0 609458.0 633575.0 635423.0 637174.0 51991.7 52676.7 52774.7 54641.7 54660.2 1235.4 1267.1 1295.5 1331.0 1446.9 26113.1 27356.4 27669.3 28167.0 28174.7 40308.6 40567.8 40601.6 40891.0 41198.4 223262.0 224175.0 224233.0 224301.0 224966.0 23152.8 25073.4 25490.2 25787.4 26187.7 33163.8 33199.5 37754.1 38606.0 39768.2 30015.2 30291.2 30389.4 30824.0 31253.8 29683.3 29754.4 30103.0 30166.7 30196.8 35400.6 37051.0 37294.6 37413.1 39389.6 28223.3 28952.3 30005.7 30411.5 31180.2 27244.3 27725.0 27944.3 28015.0 28034.4 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#2] jquery.html Cycles:180 Average:28178.84 Median:19158.30 stddev:81735.67 (426.6%) stddev-sans-first:81938.31 02:26:51 INFO - PROCESS | 27277 | Values: 380.2 389.4 391.8 397.0 398.1 16301.3 17860.8 18483.4 18497.5 18502.5 17057.1 17066.7 17169.4 17258.8 18894.5 5588.3 5776.7 5806.7 5825.8 5828.9 5166.0 5468.0 5468.4 5481.5 5483.2 5438.6 5449.6 5624.3 6088.0 6088.5 6036.5 6042.9 6065.1 6087.8 6091.1 4762.7 5073.3 5078.7 5081.3 5082.4 12771.6 13063.2 17994.4 19068.6 20122.2 2057.0 2153.1 2178.3 2231.4 2243.8 9421.7 9896.5 9983.8 10026.6 10272.9 1821.3 1951.9 1960.5 1988.9 1999.0 80245.6 82365.9 82570.6 83889.0 83928.0 10530.5 10541.6 10685.8 10870.7 10937.8 15092.9 15166.4 15171.7 15191.8 15216.6 7676.0 7680.2 7816.0 7824.9 8125.6 7480.6 7581.3 7641.5 7825.1 7850.2 4492.6 4545.2 4586.5 4599.0 4631.7 1702.3 1726.9 1740.1 1750.4 1874.9 899.7 973.0 983.1 1019.3 1034.6 15638.9 15942.4 16941.1 16993.2 17248.7 994.3 1005.2 1043.2 1067.9 1082.0 9529.9 10365.9 10604.3 10658.7 10819.5 485311.0 491612.0 498223.0 498998.0 509190.0 64205.0 79805.6 80984.0 89216.6 90012.0 996.5 1010.8 1023.7 1033.4 1041.5 16684.2 16992.3 17195.2 17221.7 17347.8 36766.8 37936.4 38854.8 38915.2 39598.0 51339.0 55235.7 55360.7 55544.2 55630.7 7998.6 8177.9 8194.8 8202.1 8274.4 9086.5 11108.9 11291.3 12362.1 12476.8 10617.9 11069.2 11738.9 11780.1 11791.3 8737.0 10728.3 11086.7 11563.9 11932.5 11271.0 11594.0 11652.4 11827.6 11888.9 7346.2 7664.8 8334.4 8559.6 8573.5 10488.0 10673.6 10684.1 10700.8 10787.2 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#3] mootools.html Cycles:180 Average:5604.76 Median:4789.35 stddev:3214.41 (67.1%) stddev-sans-first:3206.29 02:26:51 INFO - PROCESS | 27277 | Values: 1188.4 1458.4 1514.6 1621.3 1786.5 7441.1 8417.5 8616.7 8619.3 8623.8 8325.1 8500.4 8504.8 8507.7 8523.0 2013.7 2057.4 2059.8 2302.7 2335.9 2281.6 2357.3 2361.9 2365.0 2365.5 2293.3 2303.5 2312.0 2314.6 2328.9 2021.4 2086.9 2235.1 2239.9 2242.3 1984.9 2187.6 2249.6 2251.6 2255.8 8122.6 8160.9 8186.4 8188.4 8195.0 4923.6 5020.5 5028.8 5063.9 5076.5 3084.8 3089.5 3130.9 3161.2 3222.9 1013.9 1015.7 1027.9 1044.8 1066.9 11690.7 11690.9 11723.6 11726.4 11747.5 4416.6 4436.6 4634.4 4636.5 4644.5 9753.0 9779.3 9780.3 9790.2 9793.5 5022.9 5072.9 5073.4 5092.1 5106.6 4212.6 4629.3 4676.7 4759.1 4767.2 3701.5 3741.5 3748.0 3771.3 3814.1 1241.2 1256.7 1259.0 1264.0 1267.9 731.5 879.3 917.4 930.3 939.8 5706.4 5812.5 5818.7 5847.2 5901.2 900.2 905.7 926.8 938.2 948.2 3812.8 3894.3 3969.5 4006.4 4046.9 10542.9 10767.2 10919.9 10988.9 11054.6 10902.7 10909.3 10910.2 10926.2 10926.6 7888.3 7917.2 8088.4 8122.6 8131.4 5711.0 5782.1 5824.0 5888.2 5909.6 10057.1 10067.1 10082.7 10105.1 10109.7 10074.6 10085.9 10181.6 10182.7 10362.7 6538.8 6914.0 6972.5 7097.4 7293.5 8004.4 8053.7 8105.1 8109.2 8113.7 7170.2 7509.3 7569.5 7656.3 7666.6 7293.7 7330.3 7347.8 7375.0 7444.3 6762.1 6822.2 6835.3 6839.1 6846.9 4746.0 4925.6 4971.2 5024.7 5026.7 4811.5 5042.6 5048.2 5160.6 5171.4 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#4] prototype.html Cycles:180 Average:4942.63 Median:5623.06 stddev:1466.20 (26.1%) stddev-sans-first:1428.90 02:26:51 INFO - PROCESS | 27277 | Values: 332.5 336.9 337.9 344.0 347.1 5488.0 5546.7 5555.3 5605.4 5640.8 5502.7 5520.6 5563.7 5565.7 5568.1 4134.5 4171.3 4297.7 4311.4 4323.0 4319.2 4327.0 4337.6 4344.8 4356.4 4152.4 4297.8 4298.2 4300.4 4328.8 4171.9 4259.5 4295.6 4302.6 4315.8 3803.7 3804.9 3808.2 3813.6 3817.3 5251.4 5428.9 5446.1 5449.3 5450.8 4925.0 4945.5 4952.1 4960.8 4975.4 5767.5 5769.6 5785.8 5830.6 5841.1 4086.0 4184.3 4184.9 4188.2 4194.1 6055.6 6055.7 6079.4 6086.4 6095.9 4268.6 4274.7 4276.6 4279.0 4303.9 4274.4 4295.5 4346.2 4349.1 4351.8 4912.6 4933.0 4955.5 4957.1 4960.6 5812.6 5848.2 5863.7 5864.4 5880.9 1486.5 1497.3 1512.2 1512.7 1518.1 966.7 1026.2 1035.4 1045.5 1054.4 5575.5 5643.3 5646.9 5672.0 5676.4 5909.7 5924.2 5985.0 6014.4 6015.5 5463.2 5696.9 5771.7 5776.6 5824.4 3244.2 3250.8 3257.3 3265.5 3275.6 6202.8 6328.7 6352.4 6353.7 6370.9 6249.2 6262.5 6265.4 6268.7 6270.6 6047.5 6252.1 6260.2 6261.3 6276.9 6045.6 6071.7 6077.7 6084.2 6091.5 5970.7 5992.3 6000.4 6003.0 6036.1 6096.8 6270.2 6310.9 6311.8 6318.7 4188.7 4208.6 4233.3 4242.9 4247.5 5988.6 6079.9 6109.3 6122.5 6129.0 5912.4 5913.2 5918.1 5930.3 5932.4 5855.6 5857.8 5862.5 5867.5 5876.3 5375.5 5655.8 5782.1 5784.1 5787.7 5905.9 5912.3 5932.4 5940.4 5946.1 5640.9 5813.4 5828.9 5841.2 5853.2 02:26:51 INFO - PROCESS | 27277 | 02:26:51 INFO - PROCESS | 27277 | [#5] yui.html Cycles:180 Average:14973.79 Median:4312.67 stddev:17871.70 (414.4%) stddev-sans-first:17889.92 02:26:51 INFO - PROCESS | 27277 | Values: 750.2 754.1 761.6 779.4 782.3 13839.4 14026.1 14069.4 14086.9 14770.9 13411.6 13425.6 13504.9 13533.5 13594.7 641.3 791.9 805.5 806.7 825.6 814.5 815.2 816.8 817.4 817.5 854.1 857.7 859.6 859.9 859.9 708.3 721.4 722.1 813.8 847.7 627.1 628.0 628.1 628.3 629.1 14194.8 14377.6 14432.9 14469.6 14564.9 14088.7 14198.0 14246.7 14427.6 14525.1 11682.1 11827.2 11833.3 11911.6 12142.2 3687.7 3748.2 3768.1 3885.3 3912.3 60904.0 61078.7 61341.0 61417.7 61582.4 10863.6 10864.8 10887.6 10969.0 11056.4 21113.8 21127.9 21143.4 21184.7 21188.9 7970.4 8126.0 8164.8 8284.9 8464.3 4285.6 4439.7 4463.2 4513.3 4591.3 3230.5 3331.7 3332.7 3334.5 3337.1 560.6 596.1 598.2 603.4 605.4 639.8 709.3 721.4 753.1 766.8 8702.9 8904.2 8969.3 8995.4 9140.3 705.4 707.3 713.8 720.8 732.2 4009.4 4115.9 4256.7 4339.7 4381.1 62750.7 64301.4 65517.3 65758.3 66107.0 55776.4 55897.4 56626.2 56733.4 56787.4 50833.2 51025.5 51495.5 52045.7 52110.0 7864.7 7905.8 8148.1 8431.3 8469.1 31979.2 32152.4 32340.2 33994.0 34026.1 39441.4 41592.8 45147.0 46008.5 46227.0 11288.6 11377.8 11543.9 11618.3 11997.9 12180.1 12351.1 12457.4 13001.2 13004.9 11827.3 11894.3 12019.8 12140.8 12498.3 10640.5 10810.8 10908.7 11143.4 11338.1 11168.9 11357.3 11914.9 12070.2 12675.2 10149.9 10200.5 10611.2 10644.0 10681.9 10802.7 10818.5 10867.3 10946.7 11081.9 02:26:51 INFO - PROCESS | 27277 | -------- Summary: end -------- 02:26:51 INFO - PROCESS | 27277 | 02:26:52 INFO - TEST-INFO | 27277: exit 0 02:26:52 INFO - TEST-OK | dromaeo_css | took 1111981ms 02:26:52 INFO - TEST-START | kraken 02:26:52 INFO - operating with platform_type : linux_ 02:26:52 INFO - Initialising browser for kraken test... 02:26:52 INFO - TEST-INFO | started process 27464 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XwfYp/profile http://localhost:58856/getInfo.html) 02:26:56 INFO - PROCESS | 27464 | __metrics Screen width/height:1600/1200 02:26:56 INFO - PROCESS | 27464 | colorDepth:24 02:26:56 INFO - PROCESS | 27464 | Browser inner width/height: 1024/697 02:26:56 INFO - PROCESS | 27464 | __metrics 02:26:57 ERROR - PROCESS | 27464 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:26:58 INFO - TEST-INFO | 27464: exit 0 02:26:58 INFO - Browser initialized. 02:26:58 INFO - Running cycle 1/1 for kraken test... 02:26:58 INFO - TEST-INFO | started process 27545 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6XwfYp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:10 INFO - PROCESS | 27545 | RSS: Main: 152899584 02:27:10 INFO - PROCESS | 27545 | 02:27:12 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58856/tests/kraken/driver.html?testName=audio-beat-detection) 02:27:13 INFO - PROCESS | 27545 | RSS: Main: 208642048 02:27:13 INFO - PROCESS | 27545 | 02:27:16 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58856/tests/kraken/driver.html?testName=audio-dft) 02:27:16 INFO - PROCESS | 27545 | RSS: Main: 193802240 02:27:16 INFO - PROCESS | 27545 | 02:27:19 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58856/tests/kraken/driver.html?testName=audio-fft) 02:27:20 INFO - PROCESS | 27545 | RSS: Main: 263897088 02:27:20 INFO - PROCESS | 27545 | 02:27:22 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58856/tests/kraken/driver.html?testName=audio-oscillator) 02:27:22 INFO - PROCESS | 27545 | RSS: Main: 172630016 02:27:22 INFO - PROCESS | 27545 | 02:27:25 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58856/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:27:25 INFO - PROCESS | 27545 | RSS: Main: 177397760 02:27:25 INFO - PROCESS | 27545 | 02:27:28 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58856/tests/kraken/driver.html?testName=imaging-darkroom) 02:27:29 INFO - PROCESS | 27545 | RSS: Main: 213176320 02:27:29 INFO - PROCESS | 27545 | 02:27:32 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58856/tests/kraken/driver.html?testName=imaging-desaturate) 02:27:33 INFO - PROCESS | 27545 | RSS: Main: 213790720 02:27:33 INFO - PROCESS | 27545 | 02:27:35 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58856/tests/kraken/driver.html?testName=json-parse-financial) 02:27:36 INFO - PROCESS | 27545 | RSS: Main: 213749760 02:27:36 INFO - PROCESS | 27545 | 02:27:38 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58856/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:27:38 INFO - PROCESS | 27545 | RSS: Main: 203448320 02:27:38 INFO - PROCESS | 27545 | 02:27:40 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:27:40 INFO - PROCESS | 27545 | RSS: Main: 203390976 02:27:40 INFO - PROCESS | 27545 | 02:27:42 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:27:43 INFO - PROCESS | 27545 | RSS: Main: 216580096 02:27:43 INFO - PROCESS | 27545 | 02:27:46 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:27:46 INFO - PROCESS | 27545 | RSS: Main: 223215616 02:27:46 INFO - PROCESS | 27545 | 02:27:49 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:27:50 INFO - PROCESS | 27545 | RSS: Main: 217931776 02:27:50 INFO - PROCESS | 27545 | 02:27:51 INFO - PROCESS | 27545 | Cycle 1(1): loaded http://localhost:58856/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58856/tests/kraken/driver.html?testName=ai-astar) 02:27:52 INFO - PROCESS | 27545 | RSS: Main: 281210880 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | __start_tp_report 02:27:52 INFO - PROCESS | 27545 | _x_x_mozilla_page_load 02:27:52 INFO - PROCESS | 27545 | _x_x_mozilla_page_load_details 02:27:52 INFO - PROCESS | 27545 | |i|pagename|runs| 02:27:52 INFO - PROCESS | 27545 | |0;ai-astar;110;111;106;111;111;114;100;112;110;111 02:27:52 INFO - PROCESS | 27545 | |1;audio-beat-detection;157;127;155;179;127;151;166;129;181;127 02:27:52 INFO - PROCESS | 27545 | |2;audio-dft;162;160;160;161;162;161;162;162;162;161 02:27:52 INFO - PROCESS | 27545 | |3;audio-fft;76;76;96;115;77;74;73;106;100;77 02:27:52 INFO - PROCESS | 27545 | |4;audio-oscillator;92;92;148;93;92;92;149;93;92;143 02:27:52 INFO - PROCESS | 27545 | |5;imaging-gaussian-blur;117;117;116;116;117;117;117;117;117;117 02:27:52 INFO - PROCESS | 27545 | |6;imaging-darkroom;145;146;145;146;146;145;145;146;146;144 02:27:52 INFO - PROCESS | 27545 | |7;imaging-desaturate;95;94;94;94;94;94;95;94;95;95 02:27:52 INFO - PROCESS | 27545 | |8;json-parse-financial;57;55;55;56;58;57;56;68;54;52 02:27:52 INFO - PROCESS | 27545 | |9;json-stringify-tinderbox;60;61;61;61;61;61;71;61;60;60 02:27:52 INFO - PROCESS | 27545 | |10;stanford-crypto-aes;76;76;74;77;75;77;77;84;77;78 02:27:52 INFO - PROCESS | 27545 | |11;stanford-crypto-ccm;138;126;125;128;128;125;121;124;156;129 02:27:52 INFO - PROCESS | 27545 | |12;stanford-crypto-pbkdf2;166;172;164;161;165;164;163;167;162;162 02:27:52 INFO - PROCESS | 27545 | |13;stanford-crypto-sha256-iterative;69;70;68;70;68;68;67;68;69;67 02:27:52 INFO - PROCESS | 27545 | __end_tp_report 02:27:52 INFO - PROCESS | 27545 | __start_cc_report 02:27:52 INFO - PROCESS | 27545 | _x_x_mozilla_cycle_collect,1621 02:27:52 INFO - PROCESS | 27545 | __end_cc_report 02:27:52 INFO - PROCESS | 27545 | __startTimestamp1461144472087__endTimestamp 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | ------- Summary: start ------- 02:27:52 INFO - PROCESS | 27545 | Number of tests: 14 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#0] ai-astar Cycles:10 Average:109.60 Median:111.00 stddev:3.92 (3.5%) stddev-sans-first:4.16 02:27:52 INFO - PROCESS | 27545 | Values: 110.0 111.0 106.0 111.0 111.0 114.0 100.0 112.0 110.0 111.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:156.00 stddev:21.50 (13.8%) stddev-sans-first:22.65 02:27:52 INFO - PROCESS | 27545 | Values: 157.0 127.0 155.0 179.0 127.0 151.0 166.0 129.0 181.0 127.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#2] audio-dft Cycles:10 Average:161.30 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 02:27:52 INFO - PROCESS | 27545 | Values: 162.0 160.0 160.0 161.0 162.0 161.0 162.0 162.0 162.0 161.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#3] audio-fft Cycles:10 Average:87.00 Median:76.00 stddev:15.64 (20.6%) stddev-sans-first:16.08 02:27:52 INFO - PROCESS | 27545 | Values: 76.0 76.0 96.0 115.0 77.0 74.0 73.0 106.0 100.0 77.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#4] audio-oscillator Cycles:10 Average:108.60 Median:92.00 stddev:26.32 (28.6%) stddev-sans-first:27.22 02:27:52 INFO - PROCESS | 27545 | Values: 92.0 92.0 148.0 93.0 92.0 92.0 149.0 93.0 92.0 143.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 02:27:52 INFO - PROCESS | 27545 | Values: 117.0 117.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.73 02:27:52 INFO - PROCESS | 27545 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 145.0 146.0 146.0 144.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#7] imaging-desaturate Cycles:10 Average:94.40 Median:94.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:27:52 INFO - PROCESS | 27545 | Values: 95.0 94.0 94.0 94.0 94.0 94.0 95.0 94.0 95.0 95.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:4.29 (7.6%) stddev-sans-first:4.55 02:27:52 INFO - PROCESS | 27545 | Values: 57.0 55.0 55.0 56.0 58.0 57.0 56.0 68.0 54.0 52.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#9] json-stringify-tinderbox Cycles:10 Average:61.70 Median:61.00 stddev:3.30 (5.4%) stddev-sans-first:3.44 02:27:52 INFO - PROCESS | 27545 | Values: 60.0 61.0 61.0 61.0 61.0 61.0 71.0 61.0 60.0 60.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:77.00 stddev:2.69 (3.5%) stddev-sans-first:2.82 02:27:52 INFO - PROCESS | 27545 | Values: 76.0 76.0 74.0 77.0 75.0 77.0 77.0 84.0 77.0 78.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:128.00 stddev:10.18 (8.0%) stddev-sans-first:10.37 02:27:52 INFO - PROCESS | 27545 | Values: 138.0 126.0 125.0 128.0 128.0 125.0 121.0 124.0 156.0 129.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.60 Median:164.50 stddev:3.20 (1.9%) stddev-sans-first:3.36 02:27:52 INFO - PROCESS | 27545 | Values: 166.0 172.0 164.0 161.0 165.0 164.0 163.0 167.0 162.0 162.0 02:27:52 INFO - PROCESS | 27545 | 02:27:52 INFO - PROCESS | 27545 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:1.12 02:27:52 INFO - PROCESS | 27545 | Values: 69.0 70.0 68.0 70.0 68.0 68.0 67.0 68.0 69.0 67.0 02:27:52 INFO - PROCESS | 27545 | -------- Summary: end -------- 02:27:52 INFO - PROCESS | 27545 | 02:27:53 INFO - TEST-INFO | 27545: exit 0 02:27:53 INFO - TEST-OK | kraken | took 60862ms 02:27:53 INFO - SUITE-END | took 1172s 02:27:53 INFO - Completed test suite (00:19:33) 02:27:53 INFO - javascript benchmark 02:27:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3060.678628743982, 3095.1643056374764, 3132.060381885434, 3140.3405284890173, 3172.524121381793, 5296.152615581508, 5311.389190243123, 5318.388385335683, 5377.0, 5392.0294347017525, 5409.6213265071465, 5457.290552228214, 5490.505854473096, 5505.559555235582, 5546.417626149247, 4836.105320515716, 4840.612750979931, 4857.708537487762, 4882.487338829425, 4948.876278093058, 4858.927116093261, 4893.804247830082, 4907.730074845882, 4916.139675556781, 4928.507149285078, 4827.855164345057, 4834.468208497063, 4872.0, 4874.8537543873745, 4878.024395120972, 4860.562549370538, 4863.756812159378, 4881.292212629184, 4896.2410826321975, 4898.118338699032, 4810.39870016248, 4852.878678033042, 4861.82983595576, 4872.6832755870755, 4899.387576552931, 5239.056969745444, 5239.79040838366, 5245.291885595434, 5268.1834315681135, 5310.70791106489, 5623.831285061455, 5633.492985631272, 5634.04221282383, 5660.660360378391, 5662.348829884575, 5608.803691870765, 5674.687892165929, 5678.063119585264, 5718.056520674084, 5726.5705072119345, 5363.597730170214, 5383.67697938125, 5387.622866399353, 5388.973055134738, 5435.374931882845, 5865.765369385262, 5885.793997210077, 5886.58793884424, 5890.410958904161, 5896.086106653475, 5460.180972854024, 5630.296212973379, 5654.151877218368, 5701.258836351248, 5742.167385729046, 5724.370319264877, 5739.569532285095, 5747.597668163272, 5748.741306641211, 5751.913721294184, 5705.600607957404, 5708.65748055118, 5719.456651618089, 5722.399148089474, 5724.79963201286, 5674.205611214434, 5692.459216374438, 5746.310442746897, 5767.336756273083, 5793.333766616893, 4373.803178856959, 4385.166818304512, 4387.078713470143, 4392.538783427758, 4429.379886815848, 3866.574676785551, 3891.8443262269757, 3924.1955399143108, 3935.35066713989, 3946.131850992777, 5344.508002311966, 5399.595030372738, 5444.1017232156255, 5491.258680078138, 5492.231087647732, 5683.54531637468, 5685.886282274331, 5693.089105743061, 5694.772209111589, 5697.430256974352, 5376.596755243372, 5402.18967154922, 5419.403865574784, 5449.128139497661, 5481.287432633732, 4969.850904472872, 4987.501249874984, 4992.450830408652, 4993.400791904995, 5033.974830125826, 5976.73104710289, 6002.69986500682, 6003.249593800775, 6005.0, 6007.759689612454, 5692.288463942007, 5708.315002199596, 5767.307923049177, 5782.2194003808945, 5789.91315130265, 6010.459058684739, 6016.63900165974, 6019.969900150471, 6020.668863212565, 6053.788117416046, 5707.172459993195, 5708.315002199763, 5712.428757124254, 5717.285339332583, 5728.198052272602, 5491.450854914477, 5770.884582308414, 5775.768969241183, 5814.563907707024, 5859.267591551056, 5610.9158362623775, 5627.662340259598, 5642.71786410686, 5647.887042259214, 5652.0674088774895, 5577.888442231051, 5604.271444712162, 5623.493885550321, 5632.352279487911, 5638.859028524155, 5463.863403414946, 5508.862278442911, 5557.0, 5557.388687244481, 5606.131049687305, 5595.944040559542, 5596.916046259391, 5611.130274807411, 5619.803306884403, 5628.212050312877, 5438.510534051954, 5491.203775452617, 5496.560275178056, 5504.724763761716, 5542.11326187808], "value": 5291.9572142035495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [601.7081715368046, 606.0969155957623, 649.6654223075114, 657.8092353217567, 661.4245606322497, 31300.217494562618, 32094.35811283773, 32147.19632009201, 32190.35619287613, 34621.0, 38810.0, 39148.41277380841, 39182.80408597953, 39242.21515569687, 39368.409473857915, 8242.546659933701, 8397.118302578234, 8437.493750374997, 8456.365772567051, 8524.360672949522, 8173.79565510864, 8251.834963300731, 8371.414001019932, 8500.362472814533, 8518.318534517255, 8359.83280334393, 8405.41162118652, 8444.61999210037, 8574.056853746082, 8750.299976001905, 8567.571621418936, 8628.568571571459, 8634.913650863473, 8637.697680581212, 8641.265492433151, 8645.783855403603, 8649.481031138152, 8760.780980475476, 8781.517016564087, 8827.558622068935, 37143.4428483573, 37499.62500374988, 37653.05867353311, 37661.43507847384, 37865.43201851974, 3187.5218717192374, 3300.3894279558117, 3351.7151042161445, 3702.9629703702885, 3997.180577981536, 27978.72021279802, 28718.71281287202, 28993.56509652357, 29298.267543311376, 29455.11634650964, 3959.109200429909, 3975.605145603067, 4129.710920235585, 4141.875743727693, 4184.4351012613215, 294503.0, 296439.0, 296748.0, 297562.0, 297692.0, 41484.58515414868, 42985.35521967173, 43012.62342207224, 52152.478475215525, 55908.0, 40512.59487405147, 40516.18967620631, 40527.59472405297, 40624.18751624951, 40659.0, 16241.51275461738, 16479.0, 16509.33962641481, 16535.25591348392, 16547.0, 11623.360715160747, 12253.142280040312, 12605.558805441766, 12732.427040783186, 12771.872281277254, 12392.81410778839, 12477.563285284972, 12480.625581232578, 12498.437570309357, 12627.87372126267, 6261.24865016201, 6372.4583410409705, 6396.84007899797, 6525.738970441224, 6546.574472659262, 979.8481235408523, 1037.227265687068, 1049.4333060147435, 1082.2910993299402, 1152.9365884876413, 30300.54549181764, 30705.539416908763, 30838.845805770827, 31726.682733172835, 31767.0, 1099.9450027498592, 1130.4404319861558, 1136.5226604825993, 1136.5624234669713, 1197.760447910404, 15790.526284211492, 16557.25492352847, 16933.915330423515, 17097.48707538776, 17386.0, 421157.0, 609458.0, 633575.0, 635423.0, 637174.0, 51991.74004129955, 52676.73661631744, 52774.73612631912, 54641.726791365785, 54660.18009729857, 1235.4193529041336, 1267.0623738433492, 1295.4947570447532, 1330.9866901330863, 1446.900355729632, 26113.086041988438, 27356.358618482955, 27669.308267292672, 28167.0, 28174.71825281721, 40308.59691403049, 40567.79716101401, 40601.59398405978, 40891.0, 41198.38202426906, 223262.0, 224175.0, 224233.0, 224301.0, 224966.0, 23152.76847231506, 25073.373165671004, 25490.23529294124, 25787.355316117246, 26187.73812261853, 33163.83418082894, 33199.502007469426, 37754.05614859541, 38606.0, 39768.20463590654, 30015.249618758833, 30291.242718932204, 30389.392212156075, 30824.0, 31253.843730781202, 29683.257918552208, 29754.40491190121, 30103.0, 30166.69833301639, 30196.849015754782, 35400.64599354076, 37051.0, 37294.62705372911, 37413.064673383386, 39389.6061039386, 28223.294417639725, 28952.276193094498, 30005.699943001164, 30411.54382684217, 31180.247554142607, 27244.318892027066, 27725.0, 27944.30139246535, 28015.0, 28034.439311214068], "value": 17724.620707179405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.16933001391976, 389.42754151397446, 391.80018190722734, 396.96427321541057, 398.08440586650715, 16301.266443010063, 17860.821391786078, 18483.353082642112, 18497.537561560934, 18502.537436564093, 17057.061861597605, 17066.658666826657, 17169.399071032516, 17258.82741172588, 18894.527636809085, 5588.273524441827, 5776.740046697888, 5806.65160090396, 5825.825225243249, 5828.883422331551, 5166.0, 5467.972660136694, 5468.425815289397, 5481.506664400204, 5483.177523371486, 5438.619296649236, 5449.591280653947, 5624.3250809902665, 6088.0259158534645, 6088.543359248052, 6036.5170786336985, 6042.879142417149, 6065.090236464522, 6087.78692745754, 6091.0558863376245, 4762.666613337068, 5073.315102461157, 5078.695278283315, 5081.339425874649, 5082.440931497532, 12771.61685149447, 13063.216207027514, 17994.37019704304, 19068.618627627508, 20122.195112195495, 2056.979430205694, 2153.1172219390132, 2178.270279456384, 2231.4421394651336, 2243.7868402501736, 9421.670241541513, 9896.455694936776, 9983.75040623983, 10026.649067282682, 10272.948635256851, 1821.298799962024, 1951.9414417567496, 1960.5490737130397, 1988.8607797454183, 1999.0, 80245.59877200636, 82365.93974662782, 82570.58714706448, 83889.0, 83928.0, 10530.473476326153, 10541.578336866593, 10685.78628427427, 10870.72823179411, 10937.781244375068, 15092.924535377253, 15166.393344266105, 15171.696566068616, 15191.848081519043, 15216.619584510476, 7675.961620191863, 7680.231976802387, 7815.960920195476, 7824.882626760603, 8125.593720313961, 7480.5885676287235, 7581.3176814087, 7641.503302285334, 7825.13923468418, 7850.175731548219, 4492.550744925481, 4545.227311357077, 4586.518415566385, 4598.97700511502, 4631.745254011062, 1702.3105642214923, 1726.8791184616957, 1740.1386313774763, 1750.431109889291, 1874.9437516874243, 899.7263000746455, 972.9783727086531, 983.0660872171466, 1019.2661283875598, 1034.6171916390983, 15638.9218053909, 15942.442014529435, 16941.06824124685, 16993.235304411082, 17248.655026899392, 994.3487016004528, 1005.1556692378438, 1043.1654676258963, 1067.9305845120198, 1081.9891801082047, 9529.857052144223, 10365.896341036643, 10604.310719803188, 10658.73353166177, 10819.513121909376, 485311.0, 491612.0, 498223.0, 498998.0, 509190.0, 64205.0, 79805.60097199476, 80984.0, 89216.5539172313, 90012.0, 996.5017491254373, 1010.8483727440943, 1023.6928921323722, 1033.390299723167, 1041.5313109100935, 16684.249208785877, 16992.320307188067, 17195.22621482011, 17221.655566888843, 17347.826521735125, 36766.81616592007, 37936.43095353627, 38854.805725971186, 38915.2216955665, 39598.0, 51339.0, 55235.723821380634, 55360.72319638376, 55544.16683749828, 55630.72184639051, 7998.600069996593, 8177.877331839908, 8194.754157375288, 8202.138775428493, 8274.379421543528, 9086.54567271647, 11108.889111088827, 11291.322520648788, 12362.134650574373, 12476.812847807472, 10617.946910265398, 11069.169812263952, 11738.88261117412, 11780.05759539252, 11791.29252244868, 8737.0, 10728.302660327054, 11086.722831929266, 11563.942180289381, 11932.522699091938, 11271.0, 11593.956543911088, 11652.359120248468, 11827.645170644895, 11888.940555297168, 7346.228645992308, 7664.80837979055, 8334.374921880762, 8559.57202139878, 8573.485590864568, 10488.0, 10673.626423075155, 10684.145268378667, 10700.785984280115, 10787.190960677824], "value": 8771.35621615236, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1188.4354931407577, 1458.445790599572, 1514.6364872430615, 1621.3028397788946, 1786.472990467811, 7441.144268409128, 8417.537035463047, 8616.65533378664, 8619.267362274206, 8623.784405389868, 8325.084240733515, 8500.447470914387, 8504.787380315494, 8507.744767656965, 8522.977242730882, 2013.6878783788463, 2057.351934140748, 2059.8455115866295, 2302.666113413554, 2335.8948847301913, 2281.634938409855, 2357.3281614739803, 2361.8700971446565, 2365.0, 2365.5387199496104, 2293.2776175504664, 2303.49323148907, 2311.9884400577976, 2314.618088015475, 2328.9184878529254, 2021.353166986565, 2086.9478263043393, 2235.0724449353497, 2239.8656080635214, 2242.2600541821243, 1984.9106790194476, 2187.628103222456, 2249.5725812095648, 2251.639737641986, 2255.785700358463, 8122.553259570721, 8160.877586836202, 8186.386021048445, 8188.426810123294, 8195.0, 4923.630727695438, 5020.523050310215, 5028.823991160292, 5063.8987220255385, 5076.492350764931, 3084.8457577121053, 3089.5365695145683, 3130.937381252385, 3161.2413020874824, 3222.91942701432, 1013.9036791504795, 1015.720676813882, 1027.8539428537201, 1044.843273508972, 1066.8933106689346, 11690.707732306675, 11690.941545292304, 11723.589674361356, 11726.35505047222, 11747.471363788565, 4416.558344165622, 4436.556344365602, 4634.397528321297, 4636.4899861015265, 4644.535546445396, 9753.0, 9779.31544791872, 9780.315377923476, 9790.21678265737, 9793.461359625146, 5022.949770502321, 5072.873178170502, 5073.441921388644, 5092.0579692756955, 5106.591472682177, 4212.578742125763, 4629.282461218517, 4676.672632915664, 4759.0719809636785, 4767.237242041257, 3701.481792549045, 3741.513603231617, 3748.0442487165597, 3771.30230907283, 3814.1227517670536, 1241.1932244041445, 1256.7298030923396, 1258.9550672941436, 1263.988808952834, 1267.8922291605131, 731.4550659758407, 879.2745984562762, 917.3761841947539, 930.2697382554662, 939.7603611079131, 5706.400827913092, 5812.505936995318, 5818.709064546756, 5847.210626565359, 5901.17383566301, 900.1538553759445, 905.6513242401722, 926.8285367207088, 938.1931538876561, 948.1608776233084, 3812.8284227209842, 3894.3184942634925, 3969.54350249725, 4006.3790112532606, 4046.8785936421364, 10542.894571054192, 10767.19246056549, 10919.890801092046, 10988.890111098946, 11054.557817687202, 10902.67291981226, 10909.290896091728, 10910.181736369805, 10926.235163538477, 10926.617568385069, 7888.290053895177, 7917.208279172037, 8088.393370497236, 8122.634481448349, 8131.390145738975, 5711.0, 5782.074868021096, 5824.0, 5888.234529511307, 5909.55678324136, 10057.094861462503, 10067.1442927352, 10082.747931301776, 10105.141063009727, 10109.747256318651, 10074.597016119273, 10085.949570252102, 10181.592736290762, 10182.694519164437, 10362.740931476774, 6538.8365290868105, 6913.965430172817, 6972.511924165463, 7097.361237488651, 7293.452991025588, 8004.399670024655, 8053.6778528858185, 8105.148959359182, 8109.189081091844, 8113.6754529818145, 7170.211276759656, 7509.324160825552, 7569.47013709035, 7656.349210317186, 7666.578338191453, 7293.744718934812, 7330.266973302627, 7347.7795666130105, 7375.041244638162, 7444.255574442513, 6762.053312536151, 6822.215445223665, 6835.282295358916, 6839.110915580943, 6846.931530684629, 4745.9686656506965, 4925.605951523798, 4971.154903666313, 5024.698518088926, 5026.723530205728, 4811.470738218723, 5042.596592272536, 5048.167052436307, 5160.587153027824, 5171.3535808024], "value": 4468.773694469469, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.5169742946459, 336.8955623756636, 337.9425497665397, 344.03669724770634, 347.0923534956091, 5488.0, 5546.722663866811, 5555.333359996801, 5605.355384130826, 5640.774369025245, 5502.697351645658, 5520.558355331574, 5563.693996830173, 5565.6660600364, 5568.136938774496, 4134.483189601292, 4171.270027745148, 4297.677674174433, 4311.439512863323, 4323.0, 4319.157764235975, 4327.031200803627, 4337.568602361229, 4344.761038142901, 4356.433663623725, 4152.397902304164, 4297.828086876537, 4298.161858437606, 4300.440942677447, 4328.805203765838, 4171.916561668765, 4259.488861336644, 4295.613394794484, 4302.612764851178, 4315.784210789448, 3803.695704343646, 3804.90487737806, 3808.1622043150464, 3813.637704418076, 3817.3319669057805, 5251.448597897204, 5428.9185662215095, 5446.128619420873, 5449.346078470569, 5450.836474905759, 4924.950750492485, 4945.530174633404, 4952.083864485082, 4960.776765045582, 4975.427825800007, 5767.452092051249, 5769.596128271022, 5785.82642520725, 5830.562707796932, 5841.123831425278, 4085.9591404085877, 4184.28867092595, 4184.8744537663915, 4188.193910080254, 4194.077302993367, 6055.636661800306, 6055.6677530943125, 6079.39206079393, 6086.360932102154, 6095.878082438371, 4268.615824575803, 4274.734390772833, 4276.5723427656985, 4278.978605106954, 4303.913921721548, 4274.422952901318, 4295.52749197588, 4346.195953748504, 4349.086691794759, 4351.782410879443, 4912.631552633567, 4933.0, 4955.472708918477, 4957.132501812169, 4960.603151747851, 5812.622179558315, 5848.181254624356, 5863.706814659336, 5864.44287792659, 5880.852978675567, 1486.539172856418, 1497.2663394936621, 1512.1683074309085, 1512.7125846089207, 1518.089146512106, 966.7389804752678, 1026.1534234256767, 1035.404642330663, 1045.4981608827804, 1054.4253381906879, 5575.526080283222, 5643.294588176478, 5646.943530564724, 5671.971640141773, 5676.4323567642905, 5909.674967876808, 5924.170616113747, 5985.042393217064, 6014.368491308437, 6015.526196081988, 5463.180522921593, 5696.8860622787315, 5771.740271687784, 5776.624519406225, 5824.446677565625, 3244.1565193049505, 3250.8049517029053, 3257.250832308582, 3265.461198902202, 3275.6078666566614, 6202.751889924352, 6328.71520781566, 6352.428281454691, 6353.714082866282, 6370.936290637127, 6249.187605611241, 6262.530310226751, 6265.404786545271, 6268.717907694074, 6270.648506809946, 6047.455728984237, 6252.093446450239, 6260.217472815989, 6261.279952805395, 6276.937230627726, 6045.57680962346, 6071.726772295346, 6077.726502307495, 6084.209052823105, 6091.543134264859, 5970.701464926823, 5992.310884248367, 6000.429959153874, 6002.969985150046, 6036.0644100164545, 6096.786612468542, 6270.15352927349, 6310.905336419865, 6311.810645680637, 6318.715657795502, 4188.706790524634, 4208.621224089847, 4233.259179643612, 4242.851500197478, 4247.532771395206, 5988.586505691714, 6079.878402432015, 6109.2974307955155, 6122.4795892347865, 6129.0, 5912.438318359921, 5913.231279933581, 5918.112283157388, 5930.28836539618, 5932.436418540232, 5855.619384739978, 5857.765689372377, 5862.501687356623, 5867.501262392574, 5876.265466816648, 5375.462453754593, 5655.802046928337, 5782.074868021265, 5784.132380143013, 5787.652740835563, 5905.852353691021, 5912.290525137011, 5932.436418540232, 5940.405959404025, 5946.07835785454, 5640.85897852557, 5813.3605303417435, 5828.921649494857, 5841.240638716939, 5853.239078919713], "value": 4474.998019169358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.197288900876, 754.1252147508889, 761.5811303782915, 779.4115442840655, 782.2685788787487, 13839.377228024738, 14026.088304260216, 14069.366878490468, 14086.929565352171, 14770.852291477082, 13411.59765207043, 13425.597232083028, 13504.932475337635, 13533.526326578572, 13594.660133496667, 641.2593454559991, 791.9287264146226, 805.4965646470955, 806.701520437436, 825.6119623776815, 814.5275740070745, 815.2255357410454, 816.828466022136, 817.382875928673, 817.4686453805015, 854.1245223645751, 857.7383897911135, 859.5702148925537, 859.8581234096366, 859.9011113721908, 708.2810946888886, 721.4372789224414, 722.0613202836319, 813.8209593889394, 847.7329641163014, 627.0813258576162, 627.9780207692709, 628.0892705576886, 628.3308276685316, 629.0815409502133, 14194.787078193835, 14377.56867293983, 14432.855671443256, 14469.638259043502, 14564.92717536416, 14088.718225635532, 14198.0, 14246.715065698629, 14427.567172984722, 14525.12849229039, 11682.12384071198, 11827.172097953147, 11833.290002599786, 11911.583094591648, 12142.210756300901, 3687.723420743455, 3748.231612519427, 3768.133329334241, 3885.26180025797, 3912.256671232457, 60903.999999999556, 61078.694606527126, 61341.0, 61417.69291153516, 61582.38417615811, 10863.565457381774, 10864.837027444595, 10887.618933337295, 10969.0, 11056.391898445501, 21113.78886211149, 21127.8943605281, 21143.365699029055, 21184.682229766568, 21188.9405529726, 7970.402219833536, 8126.0, 8164.7958801030445, 8284.875726864102, 8464.32285417165, 4285.5928686774705, 4439.66702497314, 4463.196624607537, 4513.277875539898, 4591.288350305708, 3230.5315729219133, 3331.68349006844, 3332.6500717424806, 3334.516140317584, 3337.1490269981, 560.6355868685387, 596.1445325957266, 598.1894532907847, 603.4026313949158, 605.352273067822, 639.763287583597, 709.2871663977669, 721.4264659595634, 753.0962844586518, 766.7623036858591, 8702.869456958151, 8904.184312053136, 8969.282457403391, 8995.415298005608, 9140.268778497704, 705.386313906894, 707.3280383635566, 713.7608901018217, 720.8486217894301, 732.1872721279376, 4009.426955944843, 4115.8765237042935, 4256.6807489438415, 4339.73961562301, 4381.079973205662, 62750.686246569385, 64301.35698643047, 65517.34482655208, 65758.34241657522, 66107.0, 55776.442235577124, 55897.44102559004, 56626.150607740914, 56733.432665672815, 56787.43212567904, 50833.23750143751, 51025.489745102816, 51495.48504514907, 52045.7397713009, 52110.0, 7864.72473463426, 7905.802354940943, 8148.144444833444, 8431.325493960347, 8469.068402475847, 31979.200519987186, 32152.356952860344, 32340.191495212806, 33994.0, 34026.14934626555, 39441.40837887376, 41592.792036039624, 45147.0, 46008.53991460043, 46227.0, 11288.586859044437, 11377.829332559853, 11543.942280288546, 11618.302901825917, 11997.940010299893, 12180.086493512845, 12351.135420520477, 12457.439415226518, 13001.219926804422, 13004.934975325063, 11827.349495777471, 11894.286342819458, 12019.75960480803, 12140.817887731515, 12498.25010499373, 10640.467976601294, 10810.783784324427, 10908.672739817817, 11143.387113708499, 11338.14963877729, 11168.944155279172, 11357.318560886373, 11914.880851191378, 12070.215435996632, 12675.239485630524, 10149.949250253701, 10200.489975501343, 10611.204159688208, 10644.0, 10681.89318106809, 10802.67591972242, 10818.51316690735, 10867.260337386972, 10946.671599852018, 11081.889181108085], "value": 6644.134465940836, "unit": "score"}], "name": "dromaeo_css", "value": 6914.908117254271, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 111.0, 106.0, 111.0, 111.0, 114.0, 100.0, 112.0, 110.0, 111.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 155.0, 179.0, 127.0, 151.0, 166.0, 129.0, 181.0, 127.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 161.0, 162.0, 161.0, 162.0, 162.0, 162.0, 161.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 96.0, 115.0, 77.0, 74.0, 73.0, 106.0, 100.0, 77.0], "value": 87.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 148.0, 93.0, 92.0, 92.0, 149.0, 93.0, 92.0, 143.0], "value": 108.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 145.0, 146.0, 146.0, 144.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 95.0, 95.0], "value": 94.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 55.0, 55.0, 56.0, 58.0, 57.0, 56.0, 68.0, 54.0, 52.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 71.0, 61.0, 60.0, 60.0], "value": 61.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 77.0, 75.0, 77.0, 77.0, 84.0, 77.0, 78.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 126.0, 125.0, 128.0, 128.0, 125.0, 121.0, 124.0, 156.0, 129.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 172.0, 164.0, 161.0, 165.0, 164.0, 163.0, 167.0, 162.0, 162.0], "value": 164.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 70.0, 68.0, 68.0, 67.0, 68.0, 69.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1531.6, "alertThreshold": 2.0}]} 02:27:53 INFO - Return code: 0 02:27:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:27:53 ERROR - # TBPL SUCCESS # 02:27:53 INFO - Running post-action listener: _resource_record_post_action 02:27:53 INFO - Running post-run listener: _resource_record_post_run 02:27:54 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 541773824; Read time: 0; Write time: 766424 02:27:54 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 251133952; Read time: 0; Write time: 433560 02:27:54 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 290639872; Read time: 0; Write time: 332864 02:27:54 INFO - Running post-run listener: _upload_blobber_files 02:27:54 INFO - Blob upload gear active. 02:27:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:27:54 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:27:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:27:54 INFO - (blobuploader) - INFO - Open directory for files ... 02:27:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:27:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:27:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:55 INFO - (blobuploader) - INFO - Done attempting. 02:27:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:27:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:27:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:27:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:27:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:27:56 INFO - (blobuploader) - INFO - Done attempting. 02:27:56 INFO - (blobuploader) - INFO - Iteration through files over. 02:27:56 INFO - Return code: 0 02:27:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:27:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:27:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bb17296504706e06a08ba93dd4fb5e743d227c80fb9707d45a064022bd327a19b2ba4734af9a3f9b37d8ee101edc940046048b5a1467dd6d6f31c48b2e253b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814fd4ef79a8a0d4b1f98da215a98d8a323848892ae273e85028501e786bdb3de58245f03850b84d511f15ef53da45befb5e11831edfe48ba40d2091c67dcf4"} 02:27:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:27:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:27:56 INFO - Contents: 02:27:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bb17296504706e06a08ba93dd4fb5e743d227c80fb9707d45a064022bd327a19b2ba4734af9a3f9b37d8ee101edc940046048b5a1467dd6d6f31c48b2e253b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814fd4ef79a8a0d4b1f98da215a98d8a323848892ae273e85028501e786bdb3de58245f03850b84d511f15ef53da45befb5e11831edfe48ba40d2091c67dcf4"} 02:27:56 INFO - Running post-run listener: copy_logs_to_upload_dir 02:27:56 INFO - Copying logs to upload dir... 02:27:56 INFO - mkdir: /builds/slave/test/build/upload/logs 02:27:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.043166 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-04-20 02:27:56.170647) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 02:27:56.174559) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 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/0bb17296504706e06a08ba93dd4fb5e743d227c80fb9707d45a064022bd327a19b2ba4734af9a3f9b37d8ee101edc940046048b5a1467dd6d6f31c48b2e253b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814fd4ef79a8a0d4b1f98da215a98d8a323848892ae273e85028501e786bdb3de58245f03850b84d511f15ef53da45befb5e11831edfe48ba40d2091c67dcf4"} build_url:https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011357 build_url: 'https://queue.taskcluster.net/v1/task/QwHLwtgpSoCGWFkQknxZ7w/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/0bb17296504706e06a08ba93dd4fb5e743d227c80fb9707d45a064022bd327a19b2ba4734af9a3f9b37d8ee101edc940046048b5a1467dd6d6f31c48b2e253b1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1814fd4ef79a8a0d4b1f98da215a98d8a323848892ae273e85028501e786bdb3de58245f03850b84d511f15ef53da45befb5e11831edfe48ba40d2091c67dcf4"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 02:27:56.200215) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:27:56.200769) ========= 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=78329bfc0fd5309db0a6e0ac000001b4-1461143244.810740-2033120410 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:27:56.283615) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 02:27:56.283981) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 02:27:56.284353) ========= ========= Total master_lag: 0.16 =========