builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1465293887.46 results: success (0) buildid: 20160606234310 builduid: e18acb0a2b7c46b5abb5f3fba11ff783 revision: bc9db3800f3c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.459734) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.460279) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.460626) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.476000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.476332) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 03:04:48-- 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% 38.0M=0s 2016-06-07 03:04:48 (38.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.317247 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.808391) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.808862) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023311 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.859802) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:47.860217) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev bc9db3800f3c --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 bc9db3800f3c --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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 03:04:48,639 Setting DEBUG logging. 2016-06-07 03:04:48,639 attempt 1/10 2016-06-07 03:04:48,639 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/bc9db3800f3c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 03:04:48,953 unpacking tar archive at: fx-team-bc9db3800f3c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.669275 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:48.543508) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:48.543905) ========= script_repo_revision: bc9db3800f3c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:48.544383) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:48.544721) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 03:04:48.556457) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-07 03:04:48.556802) ========= /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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:04:49 INFO - MultiFileLogger online at 20160607 03:04:49 in /builds/slave/test 03:04:49 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 03:04:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:04:49 INFO - {'append_to_log': False, 03:04:49 INFO - 'base_work_dir': '/builds/slave/test', 03:04:49 INFO - 'blob_upload_branch': 'Fx-Team', 03:04:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:04:49 INFO - 'branch': 'Fx-Team', 03:04:49 INFO - 'buildbot_json_path': 'buildprops.json', 03:04:49 INFO - 'config_files': ('talos/linux_config.py',), 03:04:49 INFO - 'default_actions': ('clobber', 03:04:49 INFO - 'read-buildbot-config', 03:04:49 INFO - 'download-and-extract', 03:04:49 INFO - 'populate-webroot', 03:04:49 INFO - 'create-virtualenv', 03:04:49 INFO - 'install', 03:04:49 INFO - 'run-tests'), 03:04:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:04:49 INFO - 'download_minidump_stackwalk': True, 03:04:49 INFO - 'download_symbols': 'ondemand', 03:04:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:04:49 INFO - 'tooltool.py': '/tools/tooltool.py', 03:04:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:04:49 INFO - '/tools/misc-python/virtualenv.py')}, 03:04:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:04:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:04:49 INFO - 'installer_path': 'installer.exe', 03:04:49 INFO - 'log_level': 'info', 03:04:49 INFO - 'log_name': 'talos', 03:04:49 INFO - 'log_to_console': True, 03:04:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:04:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:04:49 INFO - 'opt_config_files': (), 03:04:49 INFO - 'pip_index': False, 03:04:49 INFO - 'sps_profile': False, 03:04:49 INFO - 'sps_profile_interval': 0, 03:04:49 INFO - 'suite': 'dromaeojs', 03:04:49 INFO - 'system_bits': '32', 03:04:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:04:49 INFO - 'title': 'talos-linux64-ix-005', 03:04:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:04:49 INFO - 'use_talos_json': True, 03:04:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:04:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:04:49 INFO - 'work_dir': 'build'} 03:04:49 INFO - ##### 03:04:49 INFO - ##### Running clobber step. 03:04:49 INFO - ##### 03:04:49 INFO - Running pre-action listener: _resource_record_pre_action 03:04:49 INFO - Running main action method: clobber 03:04:49 INFO - rmtree: /builds/slave/test/build 03:04:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:04:50 INFO - Running post-action listener: _resource_record_post_action 03:04:50 INFO - ##### 03:04:50 INFO - ##### Finished clobber step (success) 03:04:50 INFO - ##### 03:04:50 INFO - ##### 03:04:50 INFO - ##### Running read-buildbot-config step. 03:04:50 INFO - ##### 03:04:50 INFO - Running pre-action listener: _resource_record_pre_action 03:04:50 INFO - Running main action method: read_buildbot_config 03:04:50 INFO - Using buildbot properties: 03:04:50 INFO - { 03:04:50 INFO - "project": "", 03:04:50 INFO - "product": "firefox", 03:04:50 INFO - "script_repo_revision": "production", 03:04:50 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:04:50 INFO - "repository": "", 03:04:50 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 03:04:50 INFO - "buildid": "20160606234310", 03:04:50 INFO - "pgo_build": "True", 03:04:50 INFO - "basedir": "/builds/slave/test", 03:04:50 INFO - "buildnumber": 773, 03:04:50 INFO - "slavename": "talos-linux64-ix-005", 03:04:50 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:04:50 INFO - "platform": "ubuntu64_hw", 03:04:50 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 03:04:50 INFO - "branch": "fx-team", 03:04:50 INFO - "repo_path": "integration/fx-team", 03:04:50 INFO - "revision": "bc9db3800f3c", 03:04:50 INFO - "stage_platform": "linux64-pgo", 03:04:50 INFO - "builduid": "e18acb0a2b7c46b5abb5f3fba11ff783", 03:04:50 INFO - "slavebuilddir": "test" 03:04:50 INFO - } 03:04:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 03:04:50 INFO - Running post-action listener: _resource_record_post_action 03:04:50 INFO - ##### 03:04:50 INFO - ##### Finished read-buildbot-config step (success) 03:04:50 INFO - ##### 03:04:50 INFO - ##### 03:04:50 INFO - ##### Running download-and-extract step. 03:04:50 INFO - ##### 03:04:50 INFO - Running pre-action listener: _resource_record_pre_action 03:04:50 INFO - Running main action method: download_and_extract 03:04:50 INFO - mkdir: /builds/slave/test/build/tests 03:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:50 INFO - https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 03:04:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 03:04:51 INFO - Downloaded 1361 bytes. 03:04:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 03:04:51 INFO - Using the following test package requirements: 03:04:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:04:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 03:04:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'jsshell-linux-x86_64.zip'], 03:04:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:04:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 03:04:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:04:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:04:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:04:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 03:04:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:04:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:04:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:51 INFO - https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:52 INFO - Downloaded 24444613 bytes. 03:04:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:04:53 INFO - Return code: 0 03:04:53 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:04:53 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')]} 03:04:53 INFO - https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:04:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 03:04:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:04:55 INFO - Downloaded 24444613 bytes. 03:04:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 03:04:56 INFO - Return code: 0 03:04: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')]} 03:04:56 INFO - https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:04:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 03:04:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:04:57 INFO - Downloaded 10833369 bytes. 03:04:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 03:04:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 03:04:57 INFO - Return code: 0 03:04:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:04:57 INFO - https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:04:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:04:59 INFO - Downloaded 59187348 bytes. 03:04:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:59 INFO - mkdir: /builds/slave/test/properties 03:04:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:04:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:04:59 INFO - Contents: 03:04:59 INFO - build_url:https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 03:04:59 INFO - Running post-action listener: _resource_record_post_action 03:04:59 INFO - Running post-action listener: set_extra_try_arguments 03:04:59 INFO - ##### 03:04:59 INFO - ##### Finished download-and-extract step (success) 03:04:59 INFO - ##### 03:04:59 INFO - ##### 03:04:59 INFO - ##### Running populate-webroot step. 03:04:59 INFO - ##### 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: populate_webroot 03:04:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:04:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:04:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:04:59 INFO - '--tppagecycles', 03:04:59 INFO - '7'], 03:04:59 INFO - 'tests': ['tsvgm']}}, 03:04:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:04:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:04:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:04:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:04:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:04:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['damp', 'tps']}, 03:04:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'tests': ['damp', 'tps']}, 03:04:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['dromaeo_dom']}, 03:04:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:04:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['a11yr', 03:04:59 INFO - 'ts_paint', 03:04:59 INFO - 'tpaint', 03:04:59 INFO - 'sessionrestore', 03:04:59 INFO - 'sessionrestore_no_auto_restore', 03:04:59 INFO - 'tabpaint']}, 03:04:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['tsvgx', 03:04:59 INFO - 'tsvgr_opacity', 03:04:59 INFO - 'tart', 03:04:59 INFO - 'tscrollx', 03:04:59 INFO - 'cart']}, 03:04:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:04:59 INFO - 'tsvgr_opacity', 03:04:59 INFO - 'tart', 03:04:59 INFO - 'tscrollx', 03:04:59 INFO - 'cart']}, 03:04:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'talos_options': ['--disable-e10s'], 03:04:59 INFO - 'tests': ['tp5o']}, 03:04:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'tests': ['tp5o']}, 03:04:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'talos_options': ['--disable-e10s', 03:04:59 INFO - '--xperf_path', 03:04:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:59 INFO - 'tests': ['tp5n']}, 03:04:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:04:59 INFO - 'talos_options': ['--xperf_path', 03:04:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:04:59 INFO - 'tests': ['tp5n']}}, 03:04:59 INFO - 'talos.zip': {'path': '', 03:04:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:04:59 INFO - Running post-action listener: _resource_record_post_action 03:04:59 INFO - ##### 03:04:59 INFO - ##### Finished populate-webroot step (success) 03:04:59 INFO - ##### 03:04:59 INFO - ##### 03:04:59 INFO - ##### Running create-virtualenv step. 03:04:59 INFO - ##### 03:04:59 INFO - Running pre-action listener: _resource_record_pre_action 03:04:59 INFO - Running main action method: create_virtualenv 03:04:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:04:59 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 03:04:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:05:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:05:00 INFO - Using real prefix '/usr' 03:05:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:05:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:05:02 INFO - Installing pip.................done. 03:05:02 INFO - Return code: 0 03:05:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:05:02 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')]} 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:02 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')]} 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:02 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:02 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 03:05:02 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 03:05:02 INFO - Using env: {'DISPLAY': ':0', 03:05:02 INFO - 'HOME': '/home/cltbld', 03:05:02 INFO - 'LANG': 'en_US.UTF-8', 03:05:02 INFO - 'LANGUAGE': 'en_US:en', 03:05:02 INFO - 'LOGNAME': 'cltbld', 03:05:02 INFO - 'MAIL': '/var/mail/cltbld', 03:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:02 INFO - 'MOZ_NO_REMOTE': '1', 03:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:02 INFO - 'NO_EM_RESTART': '1', 03:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:02 INFO - 'PWD': '/builds/slave/test', 03:05:02 INFO - 'SHELL': '/bin/bash', 03:05:02 INFO - 'SHLVL': '1', 03:05:02 INFO - 'TERM': 'linux', 03:05:02 INFO - 'TMOUT': '86400', 03:05:02 INFO - 'USER': 'cltbld', 03:05:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:02 INFO - '_': '/tools/buildbot/bin/python'} 03:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:02 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 03:05:02 INFO - Cleaning up... 03:05:02 INFO - Return code: 0 03:05:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:05:02 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')]} 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:02 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')]} 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:02 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:02 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>=3.1.1'] in /builds/slave/test/build 03:05:02 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>=3.1.1 03:05:02 INFO - Using env: {'DISPLAY': ':0', 03:05:02 INFO - 'HOME': '/home/cltbld', 03:05:02 INFO - 'LANG': 'en_US.UTF-8', 03:05:02 INFO - 'LANGUAGE': 'en_US:en', 03:05:02 INFO - 'LOGNAME': 'cltbld', 03:05:02 INFO - 'MAIL': '/var/mail/cltbld', 03:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:02 INFO - 'MOZ_NO_REMOTE': '1', 03:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:02 INFO - 'NO_EM_RESTART': '1', 03:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:02 INFO - 'PWD': '/builds/slave/test', 03:05:02 INFO - 'SHELL': '/bin/bash', 03:05:02 INFO - 'SHLVL': '1', 03:05:02 INFO - 'TERM': 'linux', 03:05:02 INFO - 'TMOUT': '86400', 03:05:02 INFO - 'USER': 'cltbld', 03:05:02 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:02 INFO - '_': '/tools/buildbot/bin/python'} 03:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:02 INFO - Downloading/unpacking psutil>=3.1.1 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:05:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:04 INFO - Installing collected packages: psutil 03:05:04 INFO - Running setup.py install for psutil 03:05:05 INFO - building 'psutil._psutil_linux' extension 03:05:05 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 03:05:05 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 03:05:05 INFO - building 'psutil._psutil_posix' extension 03:05:05 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 03:05:05 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 03:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:05:05 INFO - Successfully installed psutil 03:05:05 INFO - Cleaning up... 03:05:05 INFO - Return code: 0 03:05:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:05 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:05 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.3'] in /builds/slave/test/build 03:05:05 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.3 03:05:05 INFO - Using env: {'DISPLAY': ':0', 03:05:05 INFO - 'HOME': '/home/cltbld', 03:05:05 INFO - 'LANG': 'en_US.UTF-8', 03:05:05 INFO - 'LANGUAGE': 'en_US:en', 03:05:05 INFO - 'LOGNAME': 'cltbld', 03:05:05 INFO - 'MAIL': '/var/mail/cltbld', 03:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:05 INFO - 'MOZ_NO_REMOTE': '1', 03:05:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:05 INFO - 'NO_EM_RESTART': '1', 03:05:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:05 INFO - 'PWD': '/builds/slave/test', 03:05:05 INFO - 'SHELL': '/bin/bash', 03:05:05 INFO - 'SHLVL': '1', 03:05:05 INFO - 'TERM': 'linux', 03:05:05 INFO - 'TMOUT': '86400', 03:05:05 INFO - 'USER': 'cltbld', 03:05:05 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:05 INFO - '_': '/tools/buildbot/bin/python'} 03:05:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:05:05 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 03:05:05 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 03:05:05 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 03:05:05 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 03:05:05 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 03:05:05 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 03:05:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:05:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:05:07 INFO - Installing collected packages: mozsystemmonitor 03:05:07 INFO - Running setup.py install for mozsystemmonitor 03:05:07 INFO - Successfully installed mozsystemmonitor 03:05:07 INFO - Cleaning up... 03:05:07 INFO - Return code: 0 03:05:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:05:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:05:07 INFO - Using env: {'DISPLAY': ':0', 03:05:07 INFO - 'HOME': '/home/cltbld', 03:05:07 INFO - 'LANG': 'en_US.UTF-8', 03:05:07 INFO - 'LANGUAGE': 'en_US:en', 03:05:07 INFO - 'LOGNAME': 'cltbld', 03:05:07 INFO - 'MAIL': '/var/mail/cltbld', 03:05:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:07 INFO - 'MOZ_NO_REMOTE': '1', 03:05:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:07 INFO - 'NO_EM_RESTART': '1', 03:05:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:07 INFO - 'PWD': '/builds/slave/test', 03:05:07 INFO - 'SHELL': '/bin/bash', 03:05:07 INFO - 'SHLVL': '1', 03:05:07 INFO - 'TERM': 'linux', 03:05:07 INFO - 'TMOUT': '86400', 03:05:07 INFO - 'USER': 'cltbld', 03:05:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:07 INFO - '_': '/tools/buildbot/bin/python'} 03:05:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:08 INFO - Downloading/unpacking jsonschema==2.5.1 03:05:08 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 03:05:08 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 03:05:08 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 03:05:08 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 03:05:08 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 03:05:08 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 03:05:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:05:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:10 INFO - Downloading functools32-3.2.3-2.tar.gz 03:05:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:05:10 INFO - warning: no files found matching '*.txt' 03:05:10 INFO - no previously-included directories found matching 'build' 03:05:10 INFO - no previously-included directories found matching 'dist' 03:05:10 INFO - no previously-included directories found matching '.git*' 03:05:10 INFO - Installing collected packages: jsonschema, functools32 03:05:10 INFO - Running setup.py install for functools32 03:05:10 INFO - warning: no files found matching '*.txt' 03:05:10 INFO - no previously-included directories found matching 'build' 03:05:10 INFO - no previously-included directories found matching 'dist' 03:05:10 INFO - no previously-included directories found matching '.git*' 03:05:10 INFO - Successfully installed jsonschema functools32 03:05:10 INFO - Cleaning up... 03:05:10 INFO - Return code: 0 03:05:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:05:10 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')]} 03:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 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')]} 03:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:10 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:10 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 03:05:10 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 03:05:10 INFO - Using env: {'DISPLAY': ':0', 03:05:10 INFO - 'HOME': '/home/cltbld', 03:05:10 INFO - 'LANG': 'en_US.UTF-8', 03:05:10 INFO - 'LANGUAGE': 'en_US:en', 03:05:10 INFO - 'LOGNAME': 'cltbld', 03:05:10 INFO - 'MAIL': '/var/mail/cltbld', 03:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:10 INFO - 'MOZ_NO_REMOTE': '1', 03:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:10 INFO - 'NO_EM_RESTART': '1', 03:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:10 INFO - 'PWD': '/builds/slave/test', 03:05:10 INFO - 'SHELL': '/bin/bash', 03:05:10 INFO - 'SHLVL': '1', 03:05:10 INFO - 'TERM': 'linux', 03:05:10 INFO - 'TMOUT': '86400', 03:05:10 INFO - 'USER': 'cltbld', 03:05:10 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:10 INFO - '_': '/tools/buildbot/bin/python'} 03:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:10 INFO - Downloading/unpacking blobuploader==1.2.4 03:05:10 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 03:05:10 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 03:05:10 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 03:05:10 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 03:05:10 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 03:05:10 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 03:05:12 INFO - Downloading blobuploader-1.2.4.tar.gz 03:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:05:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:05:12 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 03:05:12 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 03:05:12 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 03:05:12 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 03:05:12 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 03:05:12 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 03:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:05:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:13 INFO - Downloading docopt-0.6.1.tar.gz 03:05:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:05:13 INFO - Installing collected packages: blobuploader, requests, docopt 03:05:13 INFO - Running setup.py install for blobuploader 03:05:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:05:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:05:13 INFO - Running setup.py install for requests 03:05:13 INFO - Running setup.py install for docopt 03:05:13 INFO - Successfully installed blobuploader requests docopt 03:05:13 INFO - Cleaning up... 03:05:13 INFO - Return code: 0 03:05:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:13 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:13 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 03:05:13 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 03:05:13 INFO - Using env: {'DISPLAY': ':0', 03:05:13 INFO - 'HOME': '/home/cltbld', 03:05:13 INFO - 'LANG': 'en_US.UTF-8', 03:05:13 INFO - 'LANGUAGE': 'en_US:en', 03:05:13 INFO - 'LOGNAME': 'cltbld', 03:05:13 INFO - 'MAIL': '/var/mail/cltbld', 03:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:13 INFO - 'MOZ_NO_REMOTE': '1', 03:05:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:13 INFO - 'NO_EM_RESTART': '1', 03:05:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:13 INFO - 'PWD': '/builds/slave/test', 03:05:13 INFO - 'SHELL': '/bin/bash', 03:05:13 INFO - 'SHLVL': '1', 03:05:13 INFO - 'TERM': 'linux', 03:05:13 INFO - 'TMOUT': '86400', 03:05:13 INFO - 'USER': 'cltbld', 03:05:13 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:13 INFO - '_': '/tools/buildbot/bin/python'} 03:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:14 INFO - Running setup.py (path:/tmp/pip-9Z28Dn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:14 INFO - Running setup.py (path:/tmp/pip-eQYjyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:14 INFO - Running setup.py (path:/tmp/pip-AjTmmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:14 INFO - Running setup.py (path:/tmp/pip-d1QhLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:14 INFO - Running setup.py (path:/tmp/pip-5dPgYV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:14 INFO - Running setup.py (path:/tmp/pip-tDmTk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:14 INFO - Running setup.py (path:/tmp/pip-AiDWjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:14 INFO - Running setup.py (path:/tmp/pip-E1OHV4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:14 INFO - Running setup.py (path:/tmp/pip-JRAuHR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:14 INFO - Running setup.py (path:/tmp/pip-Q2AyjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:14 INFO - Running setup.py (path:/tmp/pip-F6jzaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:14 INFO - Running setup.py (path:/tmp/pip-pzRG2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:14 INFO - Running setup.py (path:/tmp/pip-eoYeWR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:15 INFO - Running setup.py (path:/tmp/pip-ZH1_Cu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:15 INFO - Running setup.py (path:/tmp/pip-6T5DbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:15 INFO - Running setup.py (path:/tmp/pip-j1aT0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:15 INFO - Running setup.py (path:/tmp/pip-2V91LR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:05:15 INFO - Running setup.py install for manifestparser 03:05:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:05:15 INFO - Running setup.py install for mozcrash 03:05:15 INFO - Running setup.py install for mozdebug 03:05:15 INFO - Running setup.py install for mozdevice 03:05:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:05:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:05:15 INFO - Running setup.py install for mozfile 03:05:15 INFO - Running setup.py install for mozhttpd 03:05:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:05:15 INFO - Running setup.py install for mozinfo 03:05:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for mozInstall 03:05:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for mozleak 03:05:16 INFO - Running setup.py install for mozlog 03:05:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for moznetwork 03:05:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for mozprocess 03:05:16 INFO - Running setup.py install for mozprofile 03:05:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for mozrunner 03:05:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:05:16 INFO - Running setup.py install for mozscreenshot 03:05:16 INFO - Running setup.py install for moztest 03:05:17 INFO - Running setup.py install for mozversion 03:05:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:05:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:05:17 INFO - Cleaning up... 03:05:17 INFO - Return code: 0 03:05:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:17 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')]} 03:05:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:17 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')]} 03:05:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:17 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:17 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 03:05:17 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 03:05:17 INFO - Using env: {'DISPLAY': ':0', 03:05:17 INFO - 'HOME': '/home/cltbld', 03:05:17 INFO - 'LANG': 'en_US.UTF-8', 03:05:17 INFO - 'LANGUAGE': 'en_US:en', 03:05:17 INFO - 'LOGNAME': 'cltbld', 03:05:17 INFO - 'MAIL': '/var/mail/cltbld', 03:05:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:17 INFO - 'MOZ_NO_REMOTE': '1', 03:05:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:17 INFO - 'NO_EM_RESTART': '1', 03:05:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:17 INFO - 'PWD': '/builds/slave/test', 03:05:17 INFO - 'SHELL': '/bin/bash', 03:05:17 INFO - 'SHLVL': '1', 03:05:17 INFO - 'TERM': 'linux', 03:05:17 INFO - 'TMOUT': '86400', 03:05:17 INFO - 'USER': 'cltbld', 03:05:17 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:17 INFO - '_': '/tools/buildbot/bin/python'} 03:05:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:05:17 INFO - Running setup.py (path:/tmp/pip-KhZTi8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:05:17 INFO - Running setup.py (path:/tmp/pip-UDuGdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:05:17 INFO - Running setup.py (path:/tmp/pip-VoVdcj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:05:17 INFO - Running setup.py (path:/tmp/pip-0axqjH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:05:17 INFO - Running setup.py (path:/tmp/pip-MqG843-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:05:17 INFO - Running setup.py (path:/tmp/pip-vNkw3D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:05:17 INFO - Running setup.py (path:/tmp/pip-biQXLA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:05:17 INFO - Running setup.py (path:/tmp/pip-AWHe4N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:05:17 INFO - Running setup.py (path:/tmp/pip-aHXAqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:05:17 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)) 03:05:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:05:17 INFO - Running setup.py (path:/tmp/pip-HbREHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:05:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:05:18 INFO - Running setup.py (path:/tmp/pip-MhTs8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:05:18 INFO - Running setup.py (path:/tmp/pip-NZPKMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:05:18 INFO - Running setup.py (path:/tmp/pip-ySmW0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:05:18 INFO - Running setup.py (path:/tmp/pip-Wt0LfU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:18 INFO - Running setup.py (path:/tmp/pip-ysoMEZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:05:18 INFO - Running setup.py (path:/tmp/pip-tK9PPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:05:18 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)) 03:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:05:18 INFO - Running setup.py (path:/tmp/pip-iSPP_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:05:18 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)) 03:05:18 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)) 03:05:18 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)) 03:05:18 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)) 03:05:18 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)) 03:05:18 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)) 03:05:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:05:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:05:20 INFO - Downloading blessings-1.6.tar.gz 03:05:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:05:20 INFO - Installing collected packages: blessings 03:05:20 INFO - Running setup.py install for blessings 03:05:20 INFO - Successfully installed blessings 03:05:20 INFO - Cleaning up... 03:05:20 INFO - Return code: 0 03:05:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:05:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:20 INFO - Reading from file tmpfile_stdout 03:05:20 INFO - Current package versions: 03:05:20 INFO - argparse == 1.2.1 03:05:20 INFO - blessings == 1.6 03:05:20 INFO - blobuploader == 1.2.4 03:05:20 INFO - docopt == 0.6.1 03:05:20 INFO - functools32 == 3.2.3-2 03:05:20 INFO - jsonschema == 2.5.1 03:05:20 INFO - manifestparser == 1.1 03:05:20 INFO - mozInstall == 1.12 03:05:20 INFO - mozcrash == 0.17 03:05:20 INFO - mozdebug == 0.1 03:05:20 INFO - mozdevice == 0.48 03:05:20 INFO - mozfile == 1.2 03:05:20 INFO - mozhttpd == 0.7 03:05:20 INFO - mozinfo == 0.9 03:05:20 INFO - mozleak == 0.1 03:05:20 INFO - mozlog == 3.2 03:05:20 INFO - moznetwork == 0.27 03:05:20 INFO - mozprocess == 0.22 03:05:20 INFO - mozprofile == 0.28 03:05:20 INFO - mozrunner == 6.11 03:05:20 INFO - mozscreenshot == 0.1 03:05:20 INFO - mozsystemmonitor == 0.3 03:05:20 INFO - moztest == 0.7 03:05:20 INFO - mozversion == 1.4 03:05:20 INFO - psutil == 3.1.1 03:05:20 INFO - requests == 1.2.3 03:05:20 INFO - wsgiref == 0.1.2 03:05:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:05:20 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')]} 03:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:20 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')]} 03:05:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:20 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:20 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 03:05:20 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 03:05:20 INFO - Using env: {'DISPLAY': ':0', 03:05:20 INFO - 'HOME': '/home/cltbld', 03:05:20 INFO - 'LANG': 'en_US.UTF-8', 03:05:20 INFO - 'LANGUAGE': 'en_US:en', 03:05:20 INFO - 'LOGNAME': 'cltbld', 03:05:20 INFO - 'MAIL': '/var/mail/cltbld', 03:05:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:20 INFO - 'MOZ_NO_REMOTE': '1', 03:05:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:20 INFO - 'NO_EM_RESTART': '1', 03:05:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:20 INFO - 'PWD': '/builds/slave/test', 03:05:20 INFO - 'SHELL': '/bin/bash', 03:05:20 INFO - 'SHLVL': '1', 03:05:20 INFO - 'TERM': 'linux', 03:05:20 INFO - 'TMOUT': '86400', 03:05:20 INFO - 'USER': 'cltbld', 03:05:20 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:20 INFO - '_': '/tools/buildbot/bin/python'} 03:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 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)) 03:05:21 INFO - Cleaning up... 03:05:21 INFO - Return code: 0 03:05:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:21 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 03:05:21 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 03:05:21 INFO - Using env: {'DISPLAY': ':0', 03:05:21 INFO - 'HOME': '/home/cltbld', 03:05:21 INFO - 'LANG': 'en_US.UTF-8', 03:05:21 INFO - 'LANGUAGE': 'en_US:en', 03:05:21 INFO - 'LOGNAME': 'cltbld', 03:05:21 INFO - 'MAIL': '/var/mail/cltbld', 03:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:21 INFO - 'MOZ_NO_REMOTE': '1', 03:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:21 INFO - 'NO_EM_RESTART': '1', 03:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:21 INFO - 'PWD': '/builds/slave/test', 03:05:21 INFO - 'SHELL': '/bin/bash', 03:05:21 INFO - 'SHLVL': '1', 03:05:21 INFO - 'TERM': 'linux', 03:05:21 INFO - 'TMOUT': '86400', 03:05:21 INFO - 'USER': 'cltbld', 03:05:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:21 INFO - '_': '/tools/buildbot/bin/python'} 03:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:05:21 INFO - Cleaning up... 03:05:21 INFO - Return code: 0 03:05:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:05:21 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 0x7f58377d8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x267f8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x274c190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, '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': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', '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 03:05:21 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 03:05:21 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 03:05:21 INFO - Using env: {'DISPLAY': ':0', 03:05:21 INFO - 'HOME': '/home/cltbld', 03:05:21 INFO - 'LANG': 'en_US.UTF-8', 03:05:21 INFO - 'LANGUAGE': 'en_US:en', 03:05:21 INFO - 'LOGNAME': 'cltbld', 03:05:21 INFO - 'MAIL': '/var/mail/cltbld', 03:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:21 INFO - 'MOZ_NO_REMOTE': '1', 03:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:21 INFO - 'NO_EM_RESTART': '1', 03:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:21 INFO - 'PWD': '/builds/slave/test', 03:05:21 INFO - 'SHELL': '/bin/bash', 03:05:21 INFO - 'SHLVL': '1', 03:05:21 INFO - 'TERM': 'linux', 03:05:21 INFO - 'TMOUT': '86400', 03:05:21 INFO - 'USER': 'cltbld', 03:05:21 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:21 INFO - '_': '/tools/buildbot/bin/python'} 03:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:05:21 INFO - Downloading/unpacking flake8 03:05:21 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 03:05:21 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 03:05:21 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 03:05:21 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 03:05:21 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 03:05:21 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 03:05:23 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:05:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:05:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:23 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 03:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:05:24 INFO - no previously-included directories found matching 'docs/_build' 03:05:24 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:05:24 INFO - Running setup.py install for pep8 03:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:05:24 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:05:24 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:05:24 INFO - no previously-included directories found matching 'docs/_build' 03:05:24 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:05:24 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:05:24 INFO - Cleaning up... 03:05:24 INFO - Return code: 0 03:05:24 INFO - Running post-action listener: _resource_record_post_action 03:05:24 INFO - Running post-action listener: _start_resource_monitoring 03:05:24 INFO - Starting resource monitoring. 03:05:24 INFO - ##### 03:05:24 INFO - ##### Finished create-virtualenv step (success) 03:05:24 INFO - ##### 03:05:24 INFO - ##### 03:05:24 INFO - ##### Running install step. 03:05:24 INFO - ##### 03:05:24 INFO - Running pre-action listener: _resource_record_pre_action 03:05:24 INFO - Running main action method: install 03:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:05:24 INFO - Reading from file tmpfile_stdout 03:05:24 INFO - Detecting whether we're running mozinstall >=1.0... 03:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:05:24 INFO - Reading from file tmpfile_stdout 03:05:24 INFO - Output received: 03:05:24 INFO - Usage: mozinstall [options] installer 03:05:24 INFO - Options: 03:05:24 INFO - -h, --help show this help message and exit 03:05:24 INFO - -d DEST, --destination=DEST 03:05:24 INFO - Directory to install application into. [default: 03:05:24 INFO - "/builds/slave/test"] 03:05:24 INFO - --app=APP Application being installed. [default: firefox] 03:05:24 INFO - mkdir: /builds/slave/test/build/application 03:05:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:05:41 INFO - Reading from file tmpfile_stdout 03:05:41 INFO - Output received: 03:05:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:05:41 INFO - Running post-action listener: _resource_record_post_action 03:05:41 INFO - ##### 03:05:41 INFO - ##### Finished install step (success) 03:05:41 INFO - ##### 03:05:41 INFO - ##### 03:05:41 INFO - ##### Running run-tests step. 03:05:41 INFO - ##### 03:05:41 INFO - Running pre-action listener: _resource_record_pre_action 03:05:41 INFO - Running main action method: run_tests 03:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:05:41 INFO - Python 2.7.3 03:05:41 INFO - Return code: 0 03:05:41 INFO - grabbing minidump binary from tooltool 03:05:41 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')]} 03:05:41 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27de110>, '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 0x274a230>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x274a6c0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:05:41 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 03:05:41 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 03:05:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 03:05:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:05:41 INFO - Return code: 0 03:05:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:05:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:05:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:05:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:05:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:05:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:05:42 INFO - Return code: 0 03:05:42 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/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 03:05:42 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/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 03:05:42 INFO - Using env: {'DISPLAY': ':0', 03:05:42 INFO - 'HOME': '/home/cltbld', 03:05:42 INFO - 'LANG': 'en_US.UTF-8', 03:05:42 INFO - 'LANGUAGE': 'en_US:en', 03:05:42 INFO - 'LOGNAME': 'cltbld', 03:05:42 INFO - 'MAIL': '/var/mail/cltbld', 03:05:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:05:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:05:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:05:42 INFO - 'MOZ_NO_REMOTE': '1', 03:05:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:05:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:05:42 INFO - 'NO_EM_RESTART': '1', 03:05:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:05:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:05:42 INFO - 'PWD': '/builds/slave/test', 03:05:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:05:42 INFO - 'SHELL': '/bin/bash', 03:05:42 INFO - 'SHLVL': '1', 03:05:42 INFO - 'TERM': 'linux', 03:05:42 INFO - 'TMOUT': '86400', 03:05:42 INFO - 'USER': 'cltbld', 03:05:42 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223', 03:05:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:05:42 INFO - '_': '/tools/buildbot/bin/python'} 03:05:42 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/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 03:05:42 INFO - mozversion application_buildid: 20160606234310 03:05:42 INFO - mozversion application_changeset: bc9db3800f3c2bd3c25a98614dc6b40571d25795 03:05:42 INFO - mozversion application_display_name: Nightly 03:05:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:05:42 INFO - mozversion application_name: Firefox 03:05:42 INFO - mozversion application_remotingname: firefox 03:05:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 03:05:42 INFO - mozversion application_vendor: Mozilla 03:05:42 INFO - mozversion application_version: 50.0a1 03:05:42 INFO - mozversion platform_buildid: 20160606234310 03:05:42 INFO - mozversion platform_changeset: bc9db3800f3c2bd3c25a98614dc6b40571d25795 03:05:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 03:05:42 INFO - mozversion platform_version: 50.0a1 03:05:42 INFO - using testdate: 1465293942 03:05:42 INFO - actual date: 1465293942 03:05:42 INFO - starting webserver on 'localhost:45499' 03:05:42 INFO - SUITE-START | Running 2 tests 03:05:42 INFO - TEST-START | dromaeo_css 03:05:42 INFO - operating with platform_type : linux_ 03:05:42 INFO - Initialising browser for dromaeo_css test... 03:05:42 INFO - TEST-INFO | started process 16505 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0bIy3/profile http://localhost:45499/getInfo.html) 03:05:46 INFO - PROCESS | 16505 | __metrics Screen width/height:1600/1200 03:05:46 INFO - PROCESS | 16505 | colorDepth:24 03:05:46 INFO - PROCESS | 16505 | Browser inner width/height: 1024/697 03:05:46 INFO - PROCESS | 16505 | __metrics 03:05:47 ERROR - PROCESS | 16505 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:05:47 INFO - PROCESS | 16505 | console.error: PushService: 03:05:47 INFO - PROCESS | 16505 | stateChangeProcessEnqueue: Error transitioning state 03:05:47 INFO - PROCESS | 16505 | UnknownError 03:05:48 INFO - TEST-INFO | 16505: exit 0 03:05:48 INFO - Browser initialized. 03:05:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:05:48 INFO - TEST-INFO | started process 16590 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN0bIy3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:06:00 INFO - PROCESS | 16590 | RSS: Main: 156479488 03:06:00 INFO - PROCESS | 16590 | 03:06:51 INFO - PROCESS | 16590 | 1465294011454 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] 03:08:59 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45499/tests/dromaeo/cssquery-ext.html) 03:09:00 INFO - PROCESS | 16590 | RSS: Main: 260030464 03:09:00 INFO - PROCESS | 16590 | 03:12:03 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-ext.html (next: http://localhost:45499/tests/dromaeo/cssquery-jquery.html) 03:12:03 INFO - PROCESS | 16590 | RSS: Main: 247222272 03:12:03 INFO - PROCESS | 16590 | 03:15:05 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45499/tests/dromaeo/cssquery-mootools.html) 03:15:06 INFO - PROCESS | 16590 | RSS: Main: 237916160 03:15:06 INFO - PROCESS | 16590 | 03:18:08 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45499/tests/dromaeo/cssquery-prototype.html) 03:18:08 INFO - PROCESS | 16590 | RSS: Main: 246468608 03:18:08 INFO - PROCESS | 16590 | 03:21:11 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45499/tests/dromaeo/cssquery-yui.html) 03:21:12 INFO - PROCESS | 16590 | RSS: Main: 226549760 03:21:12 INFO - PROCESS | 16590 | 03:24:14 INFO - PROCESS | 16590 | Cycle 1(1): loaded http://localhost:45499/tests/dromaeo/cssquery-yui.html (next: http://localhost:45499/tests/dromaeo/cssquery-dojo.html) 03:24:15 INFO - PROCESS | 16590 | RSS: Main: 283635712 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | __start_tp_report 03:24:15 INFO - PROCESS | 16590 | _x_x_mozilla_page_load 03:24:15 INFO - PROCESS | 16590 | _x_x_mozilla_page_load_details 03:24:15 INFO - PROCESS | 16590 | |i|pagename|runs| 03:24:15 INFO - PROCESS | 16590 | |0;dojo.html;3073.216329835893;3098.349346637206;3121.1416860363397;3131.5772370729946;3135.216195951012;5335;5408.864778380543;5422.105352616818;5504.284443022407;5560.833175004746;5425.6202065855405;5427.565794736422;5516.862078448041;5534.4742249486235;5583.35791383991;4864.391951006124;4943.579795717368;4959.70241785494;4960.851174464772;5215.921761173567;5115.258287548303;5127.2052831811125;5157.071727089123;5161.17421212606;5177.32694749682;4855.393075865517;4939.827106051289;4944.678595891256;4948.183549714293;4965.80136794526;4929.802807887716;4939.506049395068;5026.371703537058;5032.924506132411;5059.418166910816;4908.582770464514;4969.055879382906;5002.0246052019875;5015.297858299841;5050.797968081272;5270.919461510382;5310.336207974004;5333.946660533384;5384.488473595002;5408.864778380533;5817.127430885401;5824.30108386992;5837.7664893404635;5841.912371314434;5847.56143289255;5729.684867332295;5782.132680097977;5809.099589563624;5881.294244690622;5921.851953701149;5485.424030476823;5487.396386397493;5501.449855014506;5507.146392309199;5511.063119269694;6038.849028774228;6041.697915104227;6043.848903777441;6045.516358691294;6049;5602.13166959122;5631.915521267184;5725.599208055396;5739.13912913058;5801.8549536261935;5778.971105144447;5814.5348372130975;5823.737931793079;5833.38749431312;5838.036723940587;5760.164776107441;5763.423657634203;5764.308283005982;5764.308283006066;5767.798127065533;5697.487226149667;5804.158397032406;5849.941500585025;5867.882642347129;5917.970410147922;4455.576720211575;4456.242438785414;4462.553744625577;4462.620677242471;4501.459824821042;3915.314819906505;3943.5267767867467;3957.3272543667645;3962.6037396260144;3976.940345894814;5496.587755918322;5555.2778138842505;5559.138333558305;5572.777088916479;5597.972010139923;5958.85102872423;5968.373320801254;5969.462748352582;5977.581569290108;6036.758529658852;5411.810586629449;5475.753591088411;5620.634658747168;5627.352854421712;5633.6619802811965;5007.198848184273;5037.949620503748;5041.193409054534;5041.294218809369;5081.8729531762;6077.392260773976;6082.482988945989;6083.66539840313;6084.209052823105;6087.269527656709;5677.829665110054;5750.453706897838;5887.764489420375;5889.057750759858;5894.528437724886;5925.822225333247;5991.041433370639;6000.939990600038;6017.819465416044;6069.393060693896;5678;5697.4302569742695;5719.056355701263;5720.141978703228;5736.139579063174;5572.77708891656;5809.24479817621;5818.156367326798;5831.300243970581;5839.795607153729;5760.049591817303;5770.913436298375;5773.826785196451;5773.884522309614;5797.043487824461;5748.741306641127;5772.076467765138;5772.509336706427;5776.855578610568;5778.884422311614;5482.28730265079;5482.725863706878;5529.474699903502;5549.556035517229;5678.4605462480995;5689.971550142222;5697.202391665087;5738.598298119258;5745.396733342939;5756.16535602327;5518.806841760519;5565.220869078414;5574.470425309589;5579.218909352613;5607.719614019365 03:24:15 INFO - PROCESS | 16590 | |1;ext.html;576.3919065386016;630.8927482328006;632.5192853431392;647.3300134360937;649.250116115886;31798.68201317986;44302.33546496805;44710.77644611772;44725.77637111818;44764.552354476444;46350.536494635046;46844;46845.297320540216;46931.06137877241;46947.29579056317;8662.913370866305;8845.911540884574;8850.203481686647;8854.158854908774;8858.778530536723;8672.566371681422;8830.602622881954;8834.55827208637;8834.602442890086;8836.028036915934;8856;8906.73279801607;8910.198082172603;8917;8918.108189181095;8807.823843523125;8879.866801997976;8890.244329232022;8890.955545222265;8891.466512009236;8615;8726.258268047224;8727.127287271285;8734.344924130652;8734.432261902955;41795.1640967182;42235;42353.1529369414;42375;42427.57572424267;3689.7786132832116;3728.9813550932345;3777.9244415111543;3805.6574908258112;4342.370356298351;32211.907587073376;32955.83522082398;33219.833900830585;33454.498182527284;33497.33005339904;4277.871663850089;4354.716943398669;4356.847510337155;4545.11370282795;4589.990202155554;344519;346984;347143.9999999975;347574;348062;61076.389236107956;61569.38430615637;61983.380166198665;62001;62076.68961655163;57687.71156144192;63002.68498657477;64014.35985640084;65122;65236;17133.82866171322;17265.741013884803;17273.827261727223;17306;17319.740203896952;13244.536441224704;13272.13731107475;13310.866891331156;13350.532731354357;13350.933245333712;16716.832831671527;18064.36774712879;18168.1824317906;18418.81581184171;18767.624647507248;5817.854553636193;5963.850903727442;6081.543884208613;6097.512199024068;6180.6291622502795;988.5502096546054;1034.4310629153936;1135.9204855660025;1171.800793865028;1177.5054477119631;32600.67399326024;32761.67238327634;33354.66645333516;33413.83293083519;33724.83137584345;1109.5007246738999;1157.6989982604584;1175.0305997552055;1226.2336039975016;1237.8611677256945;17841.46475605734;18126.196557912164;18315.35896243625;18426.447206583824;18886.244550217838;538411;541239.8814017792;542884;542962;543799;58455;60234.698826506465;60371;60397.69801150966;60435.697821510614;1304.5760127958451;1385.8267716535433;1411.4848080450768;1420.3324437514352;1446.6021843992776;32112.678873211902;33755.3248935015;33842.32315353728;34377;34421.655783442846;57102;57240.141397879896;57788.71105644613;57820.421795783186;57831;439020;441838;442231;443494;443902;25883.482330353665;27960.16119516418;28611.570826437204;28646.85676571687;30058.69941300559;49118;49936.75031624819;50094.499055008986;50893.74553127211;50904.74547627238;41108.177836443705;41362;41560;42383.1523369537;42489.5751042498;40105.79947100246;40240.19519609533;40457;40482.595174047885;41456;40885.38671919864;41836;41961.16077678368;42364;42466.15067698567;35089.298214035065;36861.26277474382;36891.81554092212;36902.261954760215;37581.81209093937;27755.444891101663;27760.167194984184;27992;28167.62136867818;28196 03:24:15 INFO - PROCESS | 16590 | |2;jquery.html;393.7814512945316;397.97015223858216;398.5197836606889;402.6416489324501;417.0782570519153;18062.90968545157;19246.80753192468;19715.211391544322;19752;19770.90114549427;18044.90977545114;18556.62886742264;18675.346362877302;19614.215431382763;19621;5536.501714845663;5717.342505611846;5804.216430781854;5842.766289348442;5947.643141411508;5911.201987731644;5918.201042859202;5937.22816033915;5944.435278648543;5957.731902064395;5812.854678633047;5881.617694849842;5962.672053037081;5962.701864906738;5979.671118088503;5915.526757859404;5917.852053698649;5930.080837470199;5937.346891841894;5947.851303717398;5629.521490673257;5741.138829175616;5776.855578610526;5777.075667893117;5777.306723193202;13270.933645331808;13503.392347344394;13539.59381218565;15469.994450360691;22410.215642452436;2318.9940701293426;2322.2452702871465;2347.495288512978;2394.4492766663766;2738.424930764542;9831.164351030171;9892.15916647086;10175.185985121172;10191.96160767842;10385.740356491073;1896.5543097372106;1940.8156225158586;1956.7651881774136;1975.664137096697;2033.298512013353;81166;84255.99999999939;85193.57403212944;85370;85511;10881.292715973437;11002.779944401227;11003.22977391575;11125.788349803779;11219.66341009771;15248.618784530254;15313.387464501518;15379;15386.538403847902;15418.229088545528;8043.39674524413;8268.173182681803;8331.29184019353;8467.237948584534;8467.280281176047;7951.880721789178;8049.114597394282;8153.47002444851;8246.505209687439;8305.335573154132;4631.952639251145;4744.857654270378;4775.092732380836;4832.34763306949;4848.927266091011;1884.0702707290022;1944.7666280046485;1958.5236205734934;2026.8277196438469;2045.3966080006435;866.5001470756912;1010.9696709098739;1033.256055639938;1046.325120297419;1094.179365475893;19361.903190483958;19411.2235510578;19607.607847842963;19809;20203.59592808165;967.2117224462041;988.980220395588;1036.3108532825586;1045.8809074290589;1060.3266925502207;10532;10877.184211184192;10912.781744365067;10917.908209179019;10917.945410273056;190611;191022;191081;494015;501095;66081;80890.59554702307;84820.57589712011;91785.54107229422;95476;1029.7168278723261;1037.1029059863165;1045.8169820281573;1063.3672964586215;1074.6507385099717;18027.819721802614;18061.277548898423;18433.170507326933;18609.14934137432;18662.160202790634;41544;42210.56789037107;43322.350164746924;43906.34140487959;44267.55732442763;58953;59204;60286;60297.09554356601;60961.69519152376;7357.926420735724;7667.693292268247;7929.405294602812;8233.958830205811;8822.117788221383;13348;13425.932870335586;13526.93236533811;13773.242471664154;13836.169829810244;11909;11933.701657458632;12002.75994480123;12178.330191839534;12221;11728.589499367481;11956.103292252941;12206.572769953009;12253.142280040312;12307.75384492323;11293.661190164308;11742;11835.52657893709;11884.286942783461;11963.222390544586;7464.290892365217;7760.417968652487;7987.760367188994;8040.437169398086;8160.83678326442;10882.564697412332;12071.939640302093;12082.75834483323;12326.630201093982;12560.371981401076 03:24:15 INFO - PROCESS | 16590 | |3;mootools.html;1315.5527120778934;1346.3201083452857;1455.497853240632;1516.8331483536815;1825.479738274592;8459.87310190347;8870.024297327296;8897.288216942638;9125.817483650322;9142;8836.955815220916;9029.367944243906;9033.187013168814;9036.277097832173;9039.864402033958;2319.884005799716;2355.1639168095335;2355.340504658698;2357.281029286067;2357.95284094318;2351.059576169537;2355.5759963206615;2399.78401943825;2407.38611654028;2408.12103582193;2295.6556516522487;2311.2141871763597;2317.1079134533156;2321.7446080931086;2341.625339945609;2274.818014558848;2292.094622624071;2305.700258966332;2308.665243539686;2317.7682231776857;2269.7049383580193;2270.398344438725;2272.988520108552;2275.1581914691506;2276.920307789236;8785.560721963877;8934.553272336358;8988.011318754932;8991.55042247885;8996.910030899739;5160.200168973777;5260.736963151865;5270.235815806686;5270.446603106657;5275.129603615437;3189.5056266278766;3202.519622056687;3241.351729654055;3263.233140212048;3311.503274508819;1109.4009235013084;1148.6381789736206;2085.6871469279577;2149.9892500537553;2161.427221786228;12740.17188882729;12877;12895.548655797096;12899.22604643715;12915.806262906064;4393.165298593321;4508.256137737302;4579.198640237945;4585.151746926829;4608.493065762764;9959.900400996043;10006.149477294366;10021.348612340174;10023.849642255373;10027.649032283834;5217.139172036572;5228.816991405282;5234.476552344811;5237.423883372826;5237.816676416307;4283.657307415399;4731.858044258678;4821.54195351441;4900.387451568554;4923.679960802537;3680.3375392429084;3734.4128745283147;3825.827837747308;3828.0812604974603;3862.729608927404;1084.6691759013577;1115.576081089181;1121.6466812953893;1122.2144498850837;1123.4607388453587;695.4644923409048;938.1228551304553;975.073680003999;1016.1261315268863;1044.195969103801;5980.312264089598;6037.245344331958;6088.847778805565;6182.536309776785;6205.751769929152;460.2268189441703;469.28668423995333;490.36742602043677;490.5094905094905;660.0660066006643;3784.375578029594;3983.541892682321;4002.219567184371;4024.537178224483;4038.3134867072667;10908.836367454494;11397.088232941345;11441.885581144248;11524.481398337095;11571.247868888495;10938.945305273422;11516;11525.76948461026;11531.48108335127;11554.133439992034;8315.875261871077;8386.748397548083;8465.280451161598;8546.05993340732;8570.914290857136;5877.177195192762;5936.1986131871645;5988.873949747776;6017.669028203491;6052.636841789506;10608.257421980386;10609.787804243717;10728.785424291627;10731.141508679442;10750.247482676137;10405.219608529542;10819.729506762395;10827.350358978487;10847.945760271148;10868.130549555859;6700.664966751546;7237.565746055254;7432.851342973218;7469.215732348025;7501.249875012455;8847.867281990646;8853.557322133996;8914.86627700572;8925.285977121945;8930.062343454103;7702.730404435818;7951.721689740832;8009.3192078673965;8015.679372825255;8059.959700201462;7882.211778822072;7957.084935232291;8030.478018928751;8071.596420179085;8088.029436467662;7148.356647901714;7150.928490715026;7216.96391518039;7219.422446204396;7225.385842203262;5207.114790485551;5302.6810807596385;5521.69630670317;5557.083081291703;5587.3015873015875;5097.082525145361;5127.820526281562;5233.293505376725;5271.077561426811;5335.839924802262 03:24:15 INFO - PROCESS | 16590 | |4;prototype.html;324.59912008669295;325.45811224311524;332.8169506771276;333.98664053437864;334.7088033410933;5336;5340.866478338039;5425.864353391167;5456.508914197726;5488.451154884509;5317.9468205317935;5385.892282154355;5396.514313711765;5408.378036525801;5413.83758487245;4140;4171.457710497631;4232.3228283474655;4243.278642630745;4251.192273468031;4145.875623731278;4174.22776786294;4225.7253278536955;4239.6396306313845;4241.618254357108;4163.666906647461;4196.349565817288;4197.7271477354025;4199.84504261329;4200.873973780792;3987.9202415951663;4036.495438070241;4131.421600975866;4149.128682976579;4205.537390887;3638.399664055428;3667.523221981152;3676.117731744362;3679.9264014719556;3680.7975561344115;5169.689818610896;5186.5332120109;5193.298904647862;5199.740012999373;5226.425093239741;4573.925127595013;4640.443146822369;4674.532546745332;4745.311929770164;4754.904901901942;5572.247746554244;5583.497485226349;5586.720663966786;5592.692401917893;5594.174941654479;3991.3036959292185;4061.9187616247805;4074.8166332515107;4082.7346222495444;4088.9591104089172;5792.594518383715;5846.707664616794;5856.648601083949;5869.882602347971;5885.264341957255;4153.6500637293;4168.3955826405;4175.102352994121;4175.97912010438;4182.769947652848;4222.39548971395;4222.493300803923;4225.450691410097;4236.216299984513;4238.41059602649;4633.536646335339;4795.592374648194;4809.975950120227;4812.903741925142;4825.083234185564;5666.546676265972;5685.857853553694;5688.658680479184;5692.117721753135;5705.286839145107;1446.7178900114377;1461.8538146185297;1463.158683756844;1467.33236377448;1472.2785834941017;919.2416256588208;964.0985678390728;967.5452537307455;977.9657711980046;982.3467394182932;5261.76322065508;5433.397147841396;5455.399906010336;5479.287692600016;5484.91772623411;5723.5707321950185;5774.82675519735;5776.220210271644;5785.218995435646;5812.244408226903;5267.209918512254;5383.384984504712;5426.593005524523;5430.484104010113;5430.484104010113;2856.7857410693864;2928.3171336756523;2988.1931878393148;3000.5499175123905;3062.7549796016265;5929.347771745104;5934.347221805598;5936.7031648417405;5939.940600594025;5946.375630558816;5921.703914804329;5924.5852790305125;5937.821865344046;5938.465538101592;5941.732622032019;5845.678487683133;5892.263467066617;5892.970535147382;5893.734781934738;5957.2255606771705;5750.309962804323;5752.827415177551;5767.885341915487;5779.913301300568;5781.710914454176;5510.752016159363;5635.567305226244;5717.342505611741;5740.39725828782;5745.971270143623;5909.911351329648;5917.5857689961285;5942.465178133989;5953.642781433128;5959.195508606283;4029.5164580249384;4049.3116170250537;4090.672746180358;4091.7749523775287;4093.0790572121036;5648.745806438802;5673.971630141823;5772.3650398456975;5791.536677065909;5831.212786273799;5619.297587801525;5639.210510528447;5647.491725744702;5663.743347575243;5678.5457163426;5421.5814111499;5582.553395728413;5596.104623260258;5624.3250809903075;5633.859153521031;5517.337919449692;5518.806841760519;5542.558934677094;5546.916796247979;5576.33084029919;5668.348139963957;5703.857403564778;5708.5147762439;5718.885622287447;5734.505490111815;5104.540591346797;5374.892502150014;5427.294451721251;5461.890762184814;5590.580706447114 03:24:15 INFO - PROCESS | 16590 | |5;yui.html;770.6339488742844;787.2245837849717;807.4347956430498;827.0943317067808;844.1980118887059;15252.847471525296;16572.58568535784;16574.08842513661;16588.336466541325;16617.086060266694;14482.493112741056;15405.69188616227;15553.300101495432;15581.220938953064;15611.219439028031;691.5366704308126;810.1938571121742;811.5779794506852;816.3591580609223;823.7158180427742;819.8442295963778;838.4801423117675;838.7357982235576;839.0979696825937;839.2949922065463;885.420049867338;889.884315039044;889.995550022249;890.2833219258495;890.3811850763722;714.2607401339615;842.473454091193;864.606603995187;881.0572687224673;881.2113158722939;633.1389310537666;635.825148084276;636.1348565950304;636.4113195294381;636.525788287724;15612.843871561367;15636.296366663413;15648.843511564852;15656.608584785357;15680.843191568052;14757.409703611842;14998.850011499855;15045.473408430762;15073;15217.467388641455;12823.102382833205;12896.419661115273;12941.352932353439;12988.87011129886;13028.739425211537;4448.586579482486;4466.263066594008;4513;4513.932291015637;4699.765011749399;73222;73687.63156184238;74144.25855741427;74632.62683686547;76728.61635691898;11815.940920295343;11838.171328006956;12032.699182520331;12172.14794964344;12425.937870310772;22417.77582224157;22444.775552244595;22472;22508.324750257518;22547.436314091952;8617.396782225183;8663.95668021656;8671.826563468696;8719.433236839584;8842.56893840563;4443.666724995638;4543;4705;4801.5438533339275;4884.267359895973;3511;3580.534530511017;3605.260921511084;3611.7652352596997;3620.113072297251;586.3403670870271;614.3457218062749;628.3967391304399;636.0554576453962;649.665422307512;592.2537602620729;631.1794666932968;633.6514916795744;755.2485277149271;790.9920900790919;9403.4828084456;9910.20718342531;9945.651902183388;9965.252606054575;10005.649802256887;610.4627927423927;618.6164577961603;641.371455973149;704.6406332770324;765.3303359560384;4522.819087236539;4550.817967281338;4722.976385118052;4733.881652958635;4740.976295118502;70830.29169708237;70976;71093.28906710866;103946.96053039524;106130;89666.55166724125;92842;93576;94312.52843735875;94338.5283073594;82935;83982;84186;84361;84633.57683211545;9514.636374468882;9586.616535338508;9636.024149493243;9686.225101991964;9821.22832636435;50463.49536504735;51541;52173;52281.47718522766;53579.19631205457;58315;72831.27168728245;72872.27127728655;75653.62173189099;79189;11214.943925280648;11467.369294688539;12060.638180854588;12230.816537751763;13032.934835325763;12740.554080607135;15130.924345378202;15370.84629153739;15425.768613471031;15727;13091;13336.266505341911;14482.203478808766;14493.347799348843;14670.33983470725;13978.720425591227;14507;14572.85427145715;15004.549863504113;15429.537113886601;13201.405936733063;13415.664608384868;13498.865011350154;13901.0964287321;14457.27713614336;10990.340579564932;11137;11227.49476273586;11491.8276225855;11542.769144617228;10771.81657271203;11205.943970280096;11445.484953177294;11507.827382589101;11543.134264930331 03:24:15 INFO - PROCESS | 16590 | __end_tp_report 03:24:15 INFO - PROCESS | 16590 | __start_cc_report 03:24:15 INFO - PROCESS | 16590 | _x_x_mozilla_cycle_collect,923 03:24:15 INFO - PROCESS | 16590 | __end_cc_report 03:24:15 INFO - PROCESS | 16590 | __startTimestamp1465295055244__endTimestamp 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | ------- Summary: start ------- 03:24:15 INFO - PROCESS | 16590 | Number of tests: 6 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#0] dojo.html Cycles:165 Average:5426.88 Median:5607.72 stddev:620.53 (11.1%) stddev-sans-first:594.33 03:24:15 INFO - PROCESS | 16590 | Values: 3073.2 3098.3 3121.1 3131.6 3135.2 5335.0 5408.9 5422.1 5504.3 5560.8 5425.6 5427.6 5516.9 5534.5 5583.4 4864.4 4943.6 4959.7 4960.9 5215.9 5115.3 5127.2 5157.1 5161.2 5177.3 4855.4 4939.8 4944.7 4948.2 4965.8 4929.8 4939.5 5026.4 5032.9 5059.4 4908.6 4969.1 5002.0 5015.3 5050.8 5270.9 5310.3 5333.9 5384.5 5408.9 5817.1 5824.3 5837.8 5841.9 5847.6 5729.7 5782.1 5809.1 5881.3 5921.9 5485.4 5487.4 5501.4 5507.1 5511.1 6038.8 6041.7 6043.8 6045.5 6049.0 5602.1 5631.9 5725.6 5739.1 5801.9 5779.0 5814.5 5823.7 5833.4 5838.0 5760.2 5763.4 5764.3 5764.3 5767.8 5697.5 5804.2 5849.9 5867.9 5918.0 4455.6 4456.2 4462.6 4462.6 4501.5 3915.3 3943.5 3957.3 3962.6 3976.9 5496.6 5555.3 5559.1 5572.8 5598.0 5958.9 5968.4 5969.5 5977.6 6036.8 5411.8 5475.8 5620.6 5627.4 5633.7 5007.2 5037.9 5041.2 5041.3 5081.9 6077.4 6082.5 6083.7 6084.2 6087.3 5677.8 5750.5 5887.8 5889.1 5894.5 5925.8 5991.0 6000.9 6017.8 6069.4 5678.0 5697.4 5719.1 5720.1 5736.1 5572.8 5809.2 5818.2 5831.3 5839.8 5760.0 5770.9 5773.8 5773.9 5797.0 5748.7 5772.1 5772.5 5776.9 5778.9 5482.3 5482.7 5529.5 5549.6 5678.5 5690.0 5697.2 5738.6 5745.4 5756.2 5518.8 5565.2 5574.5 5579.2 5607.7 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#1] ext.html Cycles:180 Average:61140.33 Median:42405.36 stddev:119449.32 (281.7%) stddev-sans-first:119697.86 03:24:15 INFO - PROCESS | 16590 | Values: 576.4 630.9 632.5 647.3 649.3 31798.7 44302.3 44710.8 44725.8 44764.6 46350.5 46844.0 46845.3 46931.1 46947.3 8662.9 8845.9 8850.2 8854.2 8858.8 8672.6 8830.6 8834.6 8834.6 8836.0 8856.0 8906.7 8910.2 8917.0 8918.1 8807.8 8879.9 8890.2 8891.0 8891.5 8615.0 8726.3 8727.1 8734.3 8734.4 41795.2 42235.0 42353.2 42375.0 42427.6 3689.8 3729.0 3777.9 3805.7 4342.4 32211.9 32955.8 33219.8 33454.5 33497.3 4277.9 4354.7 4356.8 4545.1 4590.0 344519.0 346984.0 347144.0 347574.0 348062.0 61076.4 61569.4 61983.4 62001.0 62076.7 57687.7 63002.7 64014.4 65122.0 65236.0 17133.8 17265.7 17273.8 17306.0 17319.7 13244.5 13272.1 13310.9 13350.5 13350.9 16716.8 18064.4 18168.2 18418.8 18767.6 5817.9 5963.9 6081.5 6097.5 6180.6 988.6 1034.4 1135.9 1171.8 1177.5 32600.7 32761.7 33354.7 33413.8 33724.8 1109.5 1157.7 1175.0 1226.2 1237.9 17841.5 18126.2 18315.4 18426.4 18886.2 538411.0 541239.9 542884.0 542962.0 543799.0 58455.0 60234.7 60371.0 60397.7 60435.7 1304.6 1385.8 1411.5 1420.3 1446.6 32112.7 33755.3 33842.3 34377.0 34421.7 57102.0 57240.1 57788.7 57820.4 57831.0 439020.0 441838.0 442231.0 443494.0 443902.0 25883.5 27960.2 28611.6 28646.9 30058.7 49118.0 49936.8 50094.5 50893.7 50904.7 41108.2 41362.0 41560.0 42383.2 42489.6 40105.8 40240.2 40457.0 40482.6 41456.0 40885.4 41836.0 41961.2 42364.0 42466.2 35089.3 36861.3 36891.8 36902.3 37581.8 27755.4 27760.2 27992.0 28167.6 28196.0 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#2] jquery.html Cycles:180 Average:23932.41 Median:2039.35 stddev:58730.23 (2879.9%) stddev-sans-first:58868.40 03:24:15 INFO - PROCESS | 16590 | Values: 393.8 398.0 398.5 402.6 417.1 18062.9 19246.8 19715.2 19752.0 19770.9 18044.9 18556.6 18675.3 19614.2 19621.0 5536.5 5717.3 5804.2 5842.8 5947.6 5911.2 5918.2 5937.2 5944.4 5957.7 5812.9 5881.6 5962.7 5962.7 5979.7 5915.5 5917.9 5930.1 5937.3 5947.9 5629.5 5741.1 5776.9 5777.1 5777.3 13270.9 13503.4 13539.6 15470.0 22410.2 2319.0 2322.2 2347.5 2394.4 2738.4 9831.2 9892.2 10175.2 10192.0 10385.7 1896.6 1940.8 1956.8 1975.7 2033.3 81166.0 84256.0 85193.6 85370.0 85511.0 10881.3 11002.8 11003.2 11125.8 11219.7 15248.6 15313.4 15379.0 15386.5 15418.2 8043.4 8268.2 8331.3 8467.2 8467.3 7951.9 8049.1 8153.5 8246.5 8305.3 4632.0 4744.9 4775.1 4832.3 4848.9 1884.1 1944.8 1958.5 2026.8 2045.4 866.5 1011.0 1033.3 1046.3 1094.2 19361.9 19411.2 19607.6 19809.0 20203.6 967.2 989.0 1036.3 1045.9 1060.3 10532.0 10877.2 10912.8 10917.9 10917.9 190611.0 191022.0 191081.0 494015.0 501095.0 66081.0 80890.6 84820.6 91785.5 95476.0 1029.7 1037.1 1045.8 1063.4 1074.7 18027.8 18061.3 18433.2 18609.1 18662.2 41544.0 42210.6 43322.4 43906.3 44267.6 58953.0 59204.0 60286.0 60297.1 60961.7 7357.9 7667.7 7929.4 8234.0 8822.1 13348.0 13425.9 13526.9 13773.2 13836.2 11909.0 11933.7 12002.8 12178.3 12221.0 11728.6 11956.1 12206.6 12253.1 12307.8 11293.7 11742.0 11835.5 11884.3 11963.2 7464.3 7760.4 7987.8 8040.4 8160.8 10882.6 12071.9 12082.8 12326.6 12560.4 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#3] mootools.html Cycles:180 Average:5904.54 Median:2522.69 stddev:3448.86 (136.7%) stddev-sans-first:3441.29 03:24:15 INFO - PROCESS | 16590 | Values: 1315.6 1346.3 1455.5 1516.8 1825.5 8459.9 8870.0 8897.3 9125.8 9142.0 8837.0 9029.4 9033.2 9036.3 9039.9 2319.9 2355.2 2355.3 2357.3 2358.0 2351.1 2355.6 2399.8 2407.4 2408.1 2295.7 2311.2 2317.1 2321.7 2341.6 2274.8 2292.1 2305.7 2308.7 2317.8 2269.7 2270.4 2273.0 2275.2 2276.9 8785.6 8934.6 8988.0 8991.6 8996.9 5160.2 5260.7 5270.2 5270.4 5275.1 3189.5 3202.5 3241.4 3263.2 3311.5 1109.4 1148.6 2085.7 2150.0 2161.4 12740.2 12877.0 12895.5 12899.2 12915.8 4393.2 4508.3 4579.2 4585.2 4608.5 9959.9 10006.1 10021.3 10023.8 10027.6 5217.1 5228.8 5234.5 5237.4 5237.8 4283.7 4731.9 4821.5 4900.4 4923.7 3680.3 3734.4 3825.8 3828.1 3862.7 1084.7 1115.6 1121.6 1122.2 1123.5 695.5 938.1 975.1 1016.1 1044.2 5980.3 6037.2 6088.8 6182.5 6205.8 460.2 469.3 490.4 490.5 660.1 3784.4 3983.5 4002.2 4024.5 4038.3 10908.8 11397.1 11441.9 11524.5 11571.2 10938.9 11516.0 11525.8 11531.5 11554.1 8315.9 8386.7 8465.3 8546.1 8570.9 5877.2 5936.2 5988.9 6017.7 6052.6 10608.3 10609.8 10728.8 10731.1 10750.2 10405.2 10819.7 10827.4 10847.9 10868.1 6700.7 7237.6 7432.9 7469.2 7501.2 8847.9 8853.6 8914.9 8925.3 8930.1 7702.7 7951.7 8009.3 8015.7 8060.0 7882.2 7957.1 8030.5 8071.6 8088.0 7148.4 7150.9 7217.0 7219.4 7225.4 5207.1 5302.7 5521.7 5557.1 5587.3 5097.1 5127.8 5233.3 5271.1 5335.8 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#4] prototype.html Cycles:180 Average:4736.76 Median:5428.89 stddev:1393.96 (25.7%) stddev-sans-first:1357.96 03:24:15 INFO - PROCESS | 16590 | Values: 324.6 325.5 332.8 334.0 334.7 5336.0 5340.9 5425.9 5456.5 5488.5 5317.9 5385.9 5396.5 5408.4 5413.8 4140.0 4171.5 4232.3 4243.3 4251.2 4145.9 4174.2 4225.7 4239.6 4241.6 4163.7 4196.3 4197.7 4199.8 4200.9 3987.9 4036.5 4131.4 4149.1 4205.5 3638.4 3667.5 3676.1 3679.9 3680.8 5169.7 5186.5 5193.3 5199.7 5226.4 4573.9 4640.4 4674.5 4745.3 4754.9 5572.2 5583.5 5586.7 5592.7 5594.2 3991.3 4061.9 4074.8 4082.7 4089.0 5792.6 5846.7 5856.6 5869.9 5885.3 4153.7 4168.4 4175.1 4176.0 4182.8 4222.4 4222.5 4225.5 4236.2 4238.4 4633.5 4795.6 4810.0 4812.9 4825.1 5666.5 5685.9 5688.7 5692.1 5705.3 1446.7 1461.9 1463.2 1467.3 1472.3 919.2 964.1 967.5 978.0 982.3 5261.8 5433.4 5455.4 5479.3 5484.9 5723.6 5774.8 5776.2 5785.2 5812.2 5267.2 5383.4 5426.6 5430.5 5430.5 2856.8 2928.3 2988.2 3000.5 3062.8 5929.3 5934.3 5936.7 5939.9 5946.4 5921.7 5924.6 5937.8 5938.5 5941.7 5845.7 5892.3 5893.0 5893.7 5957.2 5750.3 5752.8 5767.9 5779.9 5781.7 5510.8 5635.6 5717.3 5740.4 5746.0 5909.9 5917.6 5942.5 5953.6 5959.2 4029.5 4049.3 4090.7 4091.8 4093.1 5648.7 5674.0 5772.4 5791.5 5831.2 5619.3 5639.2 5647.5 5663.7 5678.5 5421.6 5582.6 5596.1 5624.3 5633.9 5517.3 5518.8 5542.6 5546.9 5576.3 5668.3 5703.9 5708.5 5718.9 5734.5 5104.5 5374.9 5427.3 5461.9 5590.6 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - PROCESS | 16590 | [#5] yui.html Cycles:180 Average:19829.95 Median:4771.26 stddev:26844.78 (562.6%) stddev-sans-first:26881.94 03:24:15 INFO - PROCESS | 16590 | Values: 770.6 787.2 807.4 827.1 844.2 15252.8 16572.6 16574.1 16588.3 16617.1 14482.5 15405.7 15553.3 15581.2 15611.2 691.5 810.2 811.6 816.4 823.7 819.8 838.5 838.7 839.1 839.3 885.4 889.9 890.0 890.3 890.4 714.3 842.5 864.6 881.1 881.2 633.1 635.8 636.1 636.4 636.5 15612.8 15636.3 15648.8 15656.6 15680.8 14757.4 14998.9 15045.5 15073.0 15217.5 12823.1 12896.4 12941.4 12988.9 13028.7 4448.6 4466.3 4513.0 4513.9 4699.8 73222.0 73687.6 74144.3 74632.6 76728.6 11815.9 11838.2 12032.7 12172.1 12425.9 22417.8 22444.8 22472.0 22508.3 22547.4 8617.4 8664.0 8671.8 8719.4 8842.6 4443.7 4543.0 4705.0 4801.5 4884.3 3511.0 3580.5 3605.3 3611.8 3620.1 586.3 614.3 628.4 636.1 649.7 592.3 631.2 633.7 755.2 791.0 9403.5 9910.2 9945.7 9965.3 10005.6 610.5 618.6 641.4 704.6 765.3 4522.8 4550.8 4723.0 4733.9 4741.0 70830.3 70976.0 71093.3 103947.0 106130.0 89666.6 92842.0 93576.0 94312.5 94338.5 82935.0 83982.0 84186.0 84361.0 84633.6 9514.6 9586.6 9636.0 9686.2 9821.2 50463.5 51541.0 52173.0 52281.5 53579.2 58315.0 72831.3 72872.3 75653.6 79189.0 11214.9 11467.4 12060.6 12230.8 13032.9 12740.6 15130.9 15370.8 15425.8 15727.0 13091.0 13336.3 14482.2 14493.3 14670.3 13978.7 14507.0 14572.9 15004.5 15429.5 13201.4 13415.7 13498.9 13901.1 14457.3 10990.3 11137.0 11227.5 11491.8 11542.8 10771.8 11205.9 11445.5 11507.8 11543.1 03:24:15 INFO - PROCESS | 16590 | -------- Summary: end -------- 03:24:15 INFO - PROCESS | 16590 | 03:24:15 INFO - TEST-INFO | 16590: exit 0 03:24:15 INFO - TEST-OK | dromaeo_css | took 1113164ms 03:24:15 INFO - TEST-START | kraken 03:24:15 INFO - operating with platform_type : linux_ 03:24:15 INFO - Initialising browser for kraken test... 03:24:15 INFO - TEST-INFO | started process 16770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJsWlG/profile http://localhost:45499/getInfo.html) 03:24:19 INFO - PROCESS | 16770 | __metrics Screen width/height:1600/1200 03:24:19 INFO - PROCESS | 16770 | colorDepth:24 03:24:19 INFO - PROCESS | 16770 | Browser inner width/height: 1024/697 03:24:19 INFO - PROCESS | 16770 | __metrics 03:24:20 ERROR - PROCESS | 16770 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 03:24:20 INFO - PROCESS | 16770 | console.error: PushService: 03:24:20 INFO - PROCESS | 16770 | stateChangeProcessEnqueue: Error transitioning state 03:24:20 INFO - PROCESS | 16770 | UnknownError 03:24:21 INFO - TEST-INFO | 16770: exit 0 03:24:21 INFO - Browser initialized. 03:24:21 INFO - Running cycle 1/1 for kraken test... 03:24:21 INFO - TEST-INFO | started process 16854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdJsWlG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:24:33 INFO - PROCESS | 16854 | RSS: Main: 155529216 03:24:33 INFO - PROCESS | 16854 | 03:24:35 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45499/tests/kraken/driver.html?testName=audio-beat-detection) 03:24:36 INFO - PROCESS | 16854 | RSS: Main: 214638592 03:24:36 INFO - PROCESS | 16854 | 03:24:39 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45499/tests/kraken/driver.html?testName=audio-dft) 03:24:39 INFO - PROCESS | 16854 | RSS: Main: 201981952 03:24:39 INFO - PROCESS | 16854 | 03:24:43 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45499/tests/kraken/driver.html?testName=audio-fft) 03:24:43 INFO - PROCESS | 16854 | RSS: Main: 269012992 03:24:43 INFO - PROCESS | 16854 | 03:24:45 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45499/tests/kraken/driver.html?testName=audio-oscillator) 03:24:46 INFO - PROCESS | 16854 | RSS: Main: 179593216 03:24:46 INFO - PROCESS | 16854 | 03:24:48 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45499/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:24:49 INFO - PROCESS | 16854 | RSS: Main: 183889920 03:24:49 INFO - PROCESS | 16854 | 03:24:52 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45499/tests/kraken/driver.html?testName=imaging-darkroom) 03:24:52 INFO - PROCESS | 16854 | RSS: Main: 218308608 03:24:52 INFO - PROCESS | 16854 | 03:24:55 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45499/tests/kraken/driver.html?testName=imaging-desaturate) 03:24:56 INFO - PROCESS | 16854 | RSS: Main: 220319744 03:24:56 INFO - PROCESS | 16854 | 03:24:59 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45499/tests/kraken/driver.html?testName=json-parse-financial) 03:24:59 INFO - PROCESS | 16854 | RSS: Main: 220119040 03:24:59 INFO - PROCESS | 16854 | 03:25:01 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45499/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:25:02 INFO - PROCESS | 16854 | RSS: Main: 204722176 03:25:02 INFO - PROCESS | 16854 | 03:25:03 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:25:04 INFO - PROCESS | 16854 | RSS: Main: 209768448 03:25:04 INFO - PROCESS | 16854 | 03:25:06 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:25:07 INFO - PROCESS | 16854 | RSS: Main: 216178688 03:25:07 INFO - PROCESS | 16854 | 03:25:09 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:25:10 INFO - PROCESS | 16854 | RSS: Main: 224002048 03:25:10 INFO - PROCESS | 16854 | 03:25:13 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:25:13 INFO - PROCESS | 16854 | RSS: Main: 225316864 03:25:13 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | Cycle 1(1): loaded http://localhost:45499/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45499/tests/kraken/driver.html?testName=ai-astar) 03:25:15 INFO - PROCESS | 16854 | RSS: Main: 268005376 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | __start_tp_report 03:25:15 INFO - PROCESS | 16854 | _x_x_mozilla_page_load 03:25:15 INFO - PROCESS | 16854 | _x_x_mozilla_page_load_details 03:25:15 INFO - PROCESS | 16854 | |i|pagename|runs| 03:25:15 INFO - PROCESS | 16854 | |0;ai-astar;111;105;110;110;109;110;111;109;111;109 03:25:15 INFO - PROCESS | 16854 | |1;audio-beat-detection;152;126;131;180;127;124;153;125;169;124 03:25:15 INFO - PROCESS | 16854 | |2;audio-dft;160;160;161;159;160;160;164;161;161;160 03:25:15 INFO - PROCESS | 16854 | |3;audio-fft;75;74;76;116;75;75;75;73;97;74 03:25:15 INFO - PROCESS | 16854 | |4;audio-oscillator;84;85;111;84;85;84;123;84;85;124 03:25:15 INFO - PROCESS | 16854 | |5;imaging-gaussian-blur;118;117;117;117;117;117;118;117;117;117 03:25:15 INFO - PROCESS | 16854 | |6;imaging-darkroom;145;146;145;145;145;145;145;145;146;145 03:25:15 INFO - PROCESS | 16854 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;96;95 03:25:15 INFO - PROCESS | 16854 | |8;json-parse-financial;51;52;52;54;51;54;52;53;52;52 03:25:15 INFO - PROCESS | 16854 | |9;json-stringify-tinderbox;60;61;61;61;62;62;62;61;61;61 03:25:15 INFO - PROCESS | 16854 | |10;stanford-crypto-aes;80;80;85;80;82;81;80;82;114;81 03:25:15 INFO - PROCESS | 16854 | |11;stanford-crypto-ccm;129;124;127;126;128;120;130;123;146;123 03:25:15 INFO - PROCESS | 16854 | |12;stanford-crypto-pbkdf2;164;163;164;163;167;161;160;170;160;161 03:25:15 INFO - PROCESS | 16854 | |13;stanford-crypto-sha256-iterative;67;63;63;62;64;64;61;66;62;62 03:25:15 INFO - PROCESS | 16854 | __end_tp_report 03:25:15 INFO - PROCESS | 16854 | __start_cc_report 03:25:15 INFO - PROCESS | 16854 | _x_x_mozilla_cycle_collect,1605 03:25:15 INFO - PROCESS | 16854 | __end_cc_report 03:25:15 INFO - PROCESS | 16854 | __startTimestamp1465295115589__endTimestamp 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | ------- Summary: start ------- 03:25:15 INFO - PROCESS | 16854 | Number of tests: 14 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#0] ai-astar Cycles:10 Average:109.50 Median:110.00 stddev:1.78 (1.6%) stddev-sans-first:1.80 03:25:15 INFO - PROCESS | 16854 | Values: 111.0 105.0 110.0 110.0 109.0 110.0 111.0 109.0 111.0 109.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:141.50 stddev:20.88 (14.8%) stddev-sans-first:21.77 03:25:15 INFO - PROCESS | 16854 | Values: 152.0 126.0 131.0 180.0 127.0 124.0 153.0 125.0 169.0 124.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.35 (0.8%) stddev-sans-first:1.41 03:25:15 INFO - PROCESS | 16854 | Values: 160.0 160.0 161.0 159.0 160.0 160.0 164.0 161.0 161.0 160.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#3] audio-fft Cycles:10 Average:81.00 Median:75.00 stddev:14.19 (18.9%) stddev-sans-first:14.88 03:25:15 INFO - PROCESS | 16854 | Values: 75.0 74.0 76.0 116.0 75.0 75.0 75.0 73.0 97.0 74.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#4] audio-oscillator Cycles:10 Average:94.90 Median:84.00 stddev:17.21 (20.5%) stddev-sans-first:17.79 03:25:15 INFO - PROCESS | 16854 | Values: 84.0 85.0 111.0 84.0 85.0 84.0 123.0 84.0 85.0 124.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 03:25:15 INFO - PROCESS | 16854 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#6] imaging-darkroom Cycles:10 Average:145.20 Median:145.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 03:25:15 INFO - PROCESS | 16854 | Values: 145.0 146.0 145.0 145.0 145.0 145.0 145.0 145.0 146.0 145.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 03:25:15 INFO - PROCESS | 16854 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#8] json-parse-financial Cycles:10 Average:52.30 Median:52.00 stddev:1.06 (2.0%) stddev-sans-first:1.01 03:25:15 INFO - PROCESS | 16854 | Values: 51.0 52.0 52.0 54.0 51.0 54.0 52.0 53.0 52.0 52.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#9] json-stringify-tinderbox Cycles:10 Average:61.20 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.50 03:25:15 INFO - PROCESS | 16854 | Values: 60.0 61.0 61.0 61.0 62.0 62.0 62.0 61.0 61.0 61.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:81.00 stddev:10.48 (12.9%) stddev-sans-first:10.99 03:25:15 INFO - PROCESS | 16854 | Values: 80.0 80.0 85.0 80.0 82.0 81.0 80.0 82.0 114.0 81.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:127.50 stddev:7.17 (5.6%) stddev-sans-first:7.58 03:25:15 INFO - PROCESS | 16854 | Values: 129.0 124.0 127.0 126.0 128.0 120.0 130.0 123.0 146.0 123.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.30 Median:163.50 stddev:3.20 (2.0%) stddev-sans-first:3.38 03:25:15 INFO - PROCESS | 16854 | Values: 164.0 163.0 164.0 163.0 167.0 161.0 160.0 170.0 160.0 161.0 03:25:15 INFO - PROCESS | 16854 | 03:25:15 INFO - PROCESS | 16854 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.40 Median:63.50 stddev:1.90 (3.0%) stddev-sans-first:1.50 03:25:15 INFO - PROCESS | 16854 | Values: 67.0 63.0 63.0 62.0 64.0 64.0 61.0 66.0 62.0 62.0 03:25:15 INFO - PROCESS | 16854 | -------- Summary: end -------- 03:25:15 INFO - PROCESS | 16854 | 03:25:16 INFO - TEST-INFO | 16854: exit 0 03:25:16 INFO - TEST-OK | kraken | took 60587ms 03:25:16 INFO - SUITE-END | took 1173s 03:25:16 INFO - Completed test suite (00:19:33) 03:25:16 INFO - javascript benchmark 03:25:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3073.216329835893, 3098.349346637206, 3121.1416860363397, 3131.5772370729946, 3135.216195951012, 5335.0, 5408.864778380543, 5422.105352616818, 5504.284443022407, 5560.833175004746, 5425.6202065855405, 5427.565794736422, 5516.862078448041, 5534.4742249486235, 5583.35791383991, 4864.391951006124, 4943.579795717368, 4959.70241785494, 4960.851174464772, 5215.921761173567, 5115.258287548303, 5127.2052831811125, 5157.071727089123, 5161.17421212606, 5177.32694749682, 4855.393075865517, 4939.827106051289, 4944.678595891256, 4948.183549714293, 4965.80136794526, 4929.802807887716, 4939.506049395068, 5026.371703537058, 5032.924506132411, 5059.418166910816, 4908.582770464514, 4969.055879382906, 5002.0246052019875, 5015.297858299841, 5050.797968081272, 5270.919461510382, 5310.336207974004, 5333.946660533384, 5384.488473595002, 5408.864778380533, 5817.127430885401, 5824.30108386992, 5837.7664893404635, 5841.912371314434, 5847.56143289255, 5729.684867332295, 5782.132680097977, 5809.099589563624, 5881.294244690622, 5921.851953701149, 5485.424030476823, 5487.396386397493, 5501.449855014506, 5507.146392309199, 5511.063119269694, 6038.849028774228, 6041.697915104227, 6043.848903777441, 6045.516358691294, 6049.0, 5602.13166959122, 5631.915521267184, 5725.599208055396, 5739.13912913058, 5801.8549536261935, 5778.971105144447, 5814.5348372130975, 5823.737931793079, 5833.38749431312, 5838.036723940587, 5760.164776107441, 5763.423657634203, 5764.308283005982, 5764.308283006066, 5767.798127065533, 5697.487226149667, 5804.158397032406, 5849.941500585025, 5867.882642347129, 5917.970410147922, 4455.576720211575, 4456.242438785414, 4462.553744625577, 4462.620677242471, 4501.459824821042, 3915.314819906505, 3943.5267767867467, 3957.3272543667645, 3962.6037396260144, 3976.940345894814, 5496.587755918322, 5555.2778138842505, 5559.138333558305, 5572.777088916479, 5597.972010139923, 5958.85102872423, 5968.373320801254, 5969.462748352582, 5977.581569290108, 6036.758529658852, 5411.810586629449, 5475.753591088411, 5620.634658747168, 5627.352854421712, 5633.6619802811965, 5007.198848184273, 5037.949620503748, 5041.193409054534, 5041.294218809369, 5081.8729531762, 6077.392260773976, 6082.482988945989, 6083.66539840313, 6084.209052823105, 6087.269527656709, 5677.829665110054, 5750.453706897838, 5887.764489420375, 5889.057750759858, 5894.528437724886, 5925.822225333247, 5991.041433370639, 6000.939990600038, 6017.819465416044, 6069.393060693896, 5678.0, 5697.4302569742695, 5719.056355701263, 5720.141978703228, 5736.139579063174, 5572.77708891656, 5809.24479817621, 5818.156367326798, 5831.300243970581, 5839.795607153729, 5760.049591817303, 5770.913436298375, 5773.826785196451, 5773.884522309614, 5797.043487824461, 5748.741306641127, 5772.076467765138, 5772.509336706427, 5776.855578610568, 5778.884422311614, 5482.28730265079, 5482.725863706878, 5529.474699903502, 5549.556035517229, 5678.4605462480995, 5689.971550142222, 5697.202391665087, 5738.598298119258, 5745.396733342939, 5756.16535602327, 5518.806841760519, 5565.220869078414, 5574.470425309589, 5579.218909352613, 5607.719614019365], "value": 5384.2630517351745, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.3919065386016, 630.8927482328006, 632.5192853431392, 647.3300134360937, 649.250116115886, 31798.68201317986, 44302.33546496805, 44710.77644611772, 44725.77637111818, 44764.552354476444, 46350.536494635046, 46844.0, 46845.297320540216, 46931.06137877241, 46947.29579056317, 8662.913370866305, 8845.911540884574, 8850.203481686647, 8854.158854908774, 8858.778530536723, 8672.566371681422, 8830.602622881954, 8834.55827208637, 8834.602442890086, 8836.028036915934, 8856.0, 8906.73279801607, 8910.198082172603, 8917.0, 8918.108189181095, 8807.823843523125, 8879.866801997976, 8890.244329232022, 8890.955545222265, 8891.466512009236, 8615.0, 8726.258268047224, 8727.127287271285, 8734.344924130652, 8734.432261902955, 41795.1640967182, 42235.0, 42353.1529369414, 42375.0, 42427.57572424267, 3689.7786132832116, 3728.9813550932345, 3777.9244415111543, 3805.6574908258112, 4342.370356298351, 32211.907587073376, 32955.83522082398, 33219.833900830585, 33454.498182527284, 33497.33005339904, 4277.871663850089, 4354.716943398669, 4356.847510337155, 4545.11370282795, 4589.990202155554, 344519.0, 346984.0, 347143.9999999975, 347574.0, 348062.0, 61076.389236107956, 61569.38430615637, 61983.380166198665, 62001.0, 62076.68961655163, 57687.71156144192, 63002.68498657477, 64014.35985640084, 65122.0, 65236.0, 17133.82866171322, 17265.741013884803, 17273.827261727223, 17306.0, 17319.740203896952, 13244.536441224704, 13272.13731107475, 13310.866891331156, 13350.532731354357, 13350.933245333712, 16716.832831671527, 18064.36774712879, 18168.1824317906, 18418.81581184171, 18767.624647507248, 5817.854553636193, 5963.850903727442, 6081.543884208613, 6097.512199024068, 6180.6291622502795, 988.5502096546054, 1034.4310629153936, 1135.9204855660025, 1171.800793865028, 1177.5054477119631, 32600.67399326024, 32761.67238327634, 33354.66645333516, 33413.83293083519, 33724.83137584345, 1109.5007246738999, 1157.6989982604584, 1175.0305997552055, 1226.2336039975016, 1237.8611677256945, 17841.46475605734, 18126.196557912164, 18315.35896243625, 18426.447206583824, 18886.244550217838, 538411.0, 541239.8814017792, 542884.0, 542962.0, 543799.0, 58455.0, 60234.698826506465, 60371.0, 60397.69801150966, 60435.697821510614, 1304.5760127958451, 1385.8267716535433, 1411.4848080450768, 1420.3324437514352, 1446.6021843992776, 32112.678873211902, 33755.3248935015, 33842.32315353728, 34377.0, 34421.655783442846, 57102.0, 57240.141397879896, 57788.71105644613, 57820.421795783186, 57831.0, 439020.0, 441838.0, 442231.0, 443494.0, 443902.0, 25883.482330353665, 27960.16119516418, 28611.570826437204, 28646.85676571687, 30058.69941300559, 49118.0, 49936.75031624819, 50094.499055008986, 50893.74553127211, 50904.74547627238, 41108.177836443705, 41362.0, 41560.0, 42383.1523369537, 42489.5751042498, 40105.79947100246, 40240.19519609533, 40457.0, 40482.595174047885, 41456.0, 40885.38671919864, 41836.0, 41961.16077678368, 42364.0, 42466.15067698567, 35089.298214035065, 36861.26277474382, 36891.81554092212, 36902.261954760215, 37581.81209093937, 27755.444891101663, 27760.167194984184, 27992.0, 28167.62136867818, 28196.0], "value": 20505.440292556417, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.7814512945316, 397.97015223858216, 398.5197836606889, 402.6416489324501, 417.0782570519153, 18062.90968545157, 19246.80753192468, 19715.211391544322, 19752.0, 19770.90114549427, 18044.90977545114, 18556.62886742264, 18675.346362877302, 19614.215431382763, 19621.0, 5536.501714845663, 5717.342505611846, 5804.216430781854, 5842.766289348442, 5947.643141411508, 5911.201987731644, 5918.201042859202, 5937.22816033915, 5944.435278648543, 5957.731902064395, 5812.854678633047, 5881.617694849842, 5962.672053037081, 5962.701864906738, 5979.671118088503, 5915.526757859404, 5917.852053698649, 5930.080837470199, 5937.346891841894, 5947.851303717398, 5629.521490673257, 5741.138829175616, 5776.855578610526, 5777.075667893117, 5777.306723193202, 13270.933645331808, 13503.392347344394, 13539.59381218565, 15469.994450360691, 22410.215642452436, 2318.9940701293426, 2322.2452702871465, 2347.495288512978, 2394.4492766663766, 2738.424930764542, 9831.164351030171, 9892.15916647086, 10175.185985121172, 10191.96160767842, 10385.740356491073, 1896.5543097372106, 1940.8156225158586, 1956.7651881774136, 1975.664137096697, 2033.298512013353, 81166.0, 84255.99999999939, 85193.57403212944, 85370.0, 85511.0, 10881.292715973437, 11002.779944401227, 11003.22977391575, 11125.788349803779, 11219.66341009771, 15248.618784530254, 15313.387464501518, 15379.0, 15386.538403847902, 15418.229088545528, 8043.39674524413, 8268.173182681803, 8331.29184019353, 8467.237948584534, 8467.280281176047, 7951.880721789178, 8049.114597394282, 8153.47002444851, 8246.505209687439, 8305.335573154132, 4631.952639251145, 4744.857654270378, 4775.092732380836, 4832.34763306949, 4848.927266091011, 1884.0702707290022, 1944.7666280046485, 1958.5236205734934, 2026.8277196438469, 2045.3966080006435, 866.5001470756912, 1010.9696709098739, 1033.256055639938, 1046.325120297419, 1094.179365475893, 19361.903190483958, 19411.2235510578, 19607.607847842963, 19809.0, 20203.59592808165, 967.2117224462041, 988.980220395588, 1036.3108532825586, 1045.8809074290589, 1060.3266925502207, 10532.0, 10877.184211184192, 10912.781744365067, 10917.908209179019, 10917.945410273056, 190611.0, 191022.0, 191081.0, 494015.0, 501095.0, 66081.0, 80890.59554702307, 84820.57589712011, 91785.54107229422, 95476.0, 1029.7168278723261, 1037.1029059863165, 1045.8169820281573, 1063.3672964586215, 1074.6507385099717, 18027.819721802614, 18061.277548898423, 18433.170507326933, 18609.14934137432, 18662.160202790634, 41544.0, 42210.56789037107, 43322.350164746924, 43906.34140487959, 44267.55732442763, 58953.0, 59204.0, 60286.0, 60297.09554356601, 60961.69519152376, 7357.926420735724, 7667.693292268247, 7929.405294602812, 8233.958830205811, 8822.117788221383, 13348.0, 13425.932870335586, 13526.93236533811, 13773.242471664154, 13836.169829810244, 11909.0, 11933.701657458632, 12002.75994480123, 12178.330191839534, 12221.0, 11728.589499367481, 11956.103292252941, 12206.572769953009, 12253.142280040312, 12307.75384492323, 11293.661190164308, 11742.0, 11835.52657893709, 11884.286942783461, 11963.222390544586, 7464.290892365217, 7760.417968652487, 7987.760367188994, 8040.437169398086, 8160.83678326442, 10882.564697412332, 12071.939640302093, 12082.75834483323, 12326.630201093982, 12560.371981401076], "value": 9111.075169531176, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1315.5527120778934, 1346.3201083452857, 1455.497853240632, 1516.8331483536815, 1825.479738274592, 8459.87310190347, 8870.024297327296, 8897.288216942638, 9125.817483650322, 9142.0, 8836.955815220916, 9029.367944243906, 9033.187013168814, 9036.277097832173, 9039.864402033958, 2319.884005799716, 2355.1639168095335, 2355.340504658698, 2357.281029286067, 2357.95284094318, 2351.059576169537, 2355.5759963206615, 2399.78401943825, 2407.38611654028, 2408.12103582193, 2295.6556516522487, 2311.2141871763597, 2317.1079134533156, 2321.7446080931086, 2341.625339945609, 2274.818014558848, 2292.094622624071, 2305.700258966332, 2308.665243539686, 2317.7682231776857, 2269.7049383580193, 2270.398344438725, 2272.988520108552, 2275.1581914691506, 2276.920307789236, 8785.560721963877, 8934.553272336358, 8988.011318754932, 8991.55042247885, 8996.910030899739, 5160.200168973777, 5260.736963151865, 5270.235815806686, 5270.446603106657, 5275.129603615437, 3189.5056266278766, 3202.519622056687, 3241.351729654055, 3263.233140212048, 3311.503274508819, 1109.4009235013084, 1148.6381789736206, 2085.6871469279577, 2149.9892500537553, 2161.427221786228, 12740.17188882729, 12877.0, 12895.548655797096, 12899.22604643715, 12915.806262906064, 4393.165298593321, 4508.256137737302, 4579.198640237945, 4585.151746926829, 4608.493065762764, 9959.900400996043, 10006.149477294366, 10021.348612340174, 10023.849642255373, 10027.649032283834, 5217.139172036572, 5228.816991405282, 5234.476552344811, 5237.423883372826, 5237.816676416307, 4283.657307415399, 4731.858044258678, 4821.54195351441, 4900.387451568554, 4923.679960802537, 3680.3375392429084, 3734.4128745283147, 3825.827837747308, 3828.0812604974603, 3862.729608927404, 1084.6691759013577, 1115.576081089181, 1121.6466812953893, 1122.2144498850837, 1123.4607388453587, 695.4644923409048, 938.1228551304553, 975.073680003999, 1016.1261315268863, 1044.195969103801, 5980.312264089598, 6037.245344331958, 6088.847778805565, 6182.536309776785, 6205.751769929152, 460.2268189441703, 469.28668423995333, 490.36742602043677, 490.5094905094905, 660.0660066006643, 3784.375578029594, 3983.541892682321, 4002.219567184371, 4024.537178224483, 4038.3134867072667, 10908.836367454494, 11397.088232941345, 11441.885581144248, 11524.481398337095, 11571.247868888495, 10938.945305273422, 11516.0, 11525.76948461026, 11531.48108335127, 11554.133439992034, 8315.875261871077, 8386.748397548083, 8465.280451161598, 8546.05993340732, 8570.914290857136, 5877.177195192762, 5936.1986131871645, 5988.873949747776, 6017.669028203491, 6052.636841789506, 10608.257421980386, 10609.787804243717, 10728.785424291627, 10731.141508679442, 10750.247482676137, 10405.219608529542, 10819.729506762395, 10827.350358978487, 10847.945760271148, 10868.130549555859, 6700.664966751546, 7237.565746055254, 7432.851342973218, 7469.215732348025, 7501.249875012455, 8847.867281990646, 8853.557322133996, 8914.86627700572, 8925.285977121945, 8930.062343454103, 7702.730404435818, 7951.721689740832, 8009.3192078673965, 8015.679372825255, 8059.959700201462, 7882.211778822072, 7957.084935232291, 8030.478018928751, 8071.596420179085, 8088.029436467662, 7148.356647901714, 7150.928490715026, 7216.96391518039, 7219.422446204396, 7225.385842203262, 5207.114790485551, 5302.6810807596385, 5521.69630670317, 5557.083081291703, 5587.3015873015875, 5097.082525145361, 5127.820526281562, 5233.293505376725, 5271.077561426811, 5335.839924802262], "value": 4635.882427681369, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.59912008669295, 325.45811224311524, 332.8169506771276, 333.98664053437864, 334.7088033410933, 5336.0, 5340.866478338039, 5425.864353391167, 5456.508914197726, 5488.451154884509, 5317.9468205317935, 5385.892282154355, 5396.514313711765, 5408.378036525801, 5413.83758487245, 4140.0, 4171.457710497631, 4232.3228283474655, 4243.278642630745, 4251.192273468031, 4145.875623731278, 4174.22776786294, 4225.7253278536955, 4239.6396306313845, 4241.618254357108, 4163.666906647461, 4196.349565817288, 4197.7271477354025, 4199.84504261329, 4200.873973780792, 3987.9202415951663, 4036.495438070241, 4131.421600975866, 4149.128682976579, 4205.537390887, 3638.399664055428, 3667.523221981152, 3676.117731744362, 3679.9264014719556, 3680.7975561344115, 5169.689818610896, 5186.5332120109, 5193.298904647862, 5199.740012999373, 5226.425093239741, 4573.925127595013, 4640.443146822369, 4674.532546745332, 4745.311929770164, 4754.904901901942, 5572.247746554244, 5583.497485226349, 5586.720663966786, 5592.692401917893, 5594.174941654479, 3991.3036959292185, 4061.9187616247805, 4074.8166332515107, 4082.7346222495444, 4088.9591104089172, 5792.594518383715, 5846.707664616794, 5856.648601083949, 5869.882602347971, 5885.264341957255, 4153.6500637293, 4168.3955826405, 4175.102352994121, 4175.97912010438, 4182.769947652848, 4222.39548971395, 4222.493300803923, 4225.450691410097, 4236.216299984513, 4238.41059602649, 4633.536646335339, 4795.592374648194, 4809.975950120227, 4812.903741925142, 4825.083234185564, 5666.546676265972, 5685.857853553694, 5688.658680479184, 5692.117721753135, 5705.286839145107, 1446.7178900114377, 1461.8538146185297, 1463.158683756844, 1467.33236377448, 1472.2785834941017, 919.2416256588208, 964.0985678390728, 967.5452537307455, 977.9657711980046, 982.3467394182932, 5261.76322065508, 5433.397147841396, 5455.399906010336, 5479.287692600016, 5484.91772623411, 5723.5707321950185, 5774.82675519735, 5776.220210271644, 5785.218995435646, 5812.244408226903, 5267.209918512254, 5383.384984504712, 5426.593005524523, 5430.484104010113, 5430.484104010113, 2856.7857410693864, 2928.3171336756523, 2988.1931878393148, 3000.5499175123905, 3062.7549796016265, 5929.347771745104, 5934.347221805598, 5936.7031648417405, 5939.940600594025, 5946.375630558816, 5921.703914804329, 5924.5852790305125, 5937.821865344046, 5938.465538101592, 5941.732622032019, 5845.678487683133, 5892.263467066617, 5892.970535147382, 5893.734781934738, 5957.2255606771705, 5750.309962804323, 5752.827415177551, 5767.885341915487, 5779.913301300568, 5781.710914454176, 5510.752016159363, 5635.567305226244, 5717.342505611741, 5740.39725828782, 5745.971270143623, 5909.911351329648, 5917.5857689961285, 5942.465178133989, 5953.642781433128, 5959.195508606283, 4029.5164580249384, 4049.3116170250537, 4090.672746180358, 4091.7749523775287, 4093.0790572121036, 5648.745806438802, 5673.971630141823, 5772.3650398456975, 5791.536677065909, 5831.212786273799, 5619.297587801525, 5639.210510528447, 5647.491725744702, 5663.743347575243, 5678.5457163426, 5421.5814111499, 5582.553395728413, 5596.104623260258, 5624.3250809903075, 5633.859153521031, 5517.337919449692, 5518.806841760519, 5542.558934677094, 5546.916796247979, 5576.33084029919, 5668.348139963957, 5703.857403564778, 5708.5147762439, 5718.885622287447, 5734.505490111815, 5104.540591346797, 5374.892502150014, 5427.294451721251, 5461.890762184814, 5590.580706447114], "value": 4291.245835678858, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [770.6339488742844, 787.2245837849717, 807.4347956430498, 827.0943317067808, 844.1980118887059, 15252.847471525296, 16572.58568535784, 16574.08842513661, 16588.336466541325, 16617.086060266694, 14482.493112741056, 15405.69188616227, 15553.300101495432, 15581.220938953064, 15611.219439028031, 691.5366704308126, 810.1938571121742, 811.5779794506852, 816.3591580609223, 823.7158180427742, 819.8442295963778, 838.4801423117675, 838.7357982235576, 839.0979696825937, 839.2949922065463, 885.420049867338, 889.884315039044, 889.995550022249, 890.2833219258495, 890.3811850763722, 714.2607401339615, 842.473454091193, 864.606603995187, 881.0572687224673, 881.2113158722939, 633.1389310537666, 635.825148084276, 636.1348565950304, 636.4113195294381, 636.525788287724, 15612.843871561367, 15636.296366663413, 15648.843511564852, 15656.608584785357, 15680.843191568052, 14757.409703611842, 14998.850011499855, 15045.473408430762, 15073.0, 15217.467388641455, 12823.102382833205, 12896.419661115273, 12941.352932353439, 12988.87011129886, 13028.739425211537, 4448.586579482486, 4466.263066594008, 4513.0, 4513.932291015637, 4699.765011749399, 73222.0, 73687.63156184238, 74144.25855741427, 74632.62683686547, 76728.61635691898, 11815.940920295343, 11838.171328006956, 12032.699182520331, 12172.14794964344, 12425.937870310772, 22417.77582224157, 22444.775552244595, 22472.0, 22508.324750257518, 22547.436314091952, 8617.396782225183, 8663.95668021656, 8671.826563468696, 8719.433236839584, 8842.56893840563, 4443.666724995638, 4543.0, 4705.0, 4801.5438533339275, 4884.267359895973, 3511.0, 3580.534530511017, 3605.260921511084, 3611.7652352596997, 3620.113072297251, 586.3403670870271, 614.3457218062749, 628.3967391304399, 636.0554576453962, 649.665422307512, 592.2537602620729, 631.1794666932968, 633.6514916795744, 755.2485277149271, 790.9920900790919, 9403.4828084456, 9910.20718342531, 9945.651902183388, 9965.252606054575, 10005.649802256887, 610.4627927423927, 618.6164577961603, 641.371455973149, 704.6406332770324, 765.3303359560384, 4522.819087236539, 4550.817967281338, 4722.976385118052, 4733.881652958635, 4740.976295118502, 70830.29169708237, 70976.0, 71093.28906710866, 103946.96053039524, 106130.0, 89666.55166724125, 92842.0, 93576.0, 94312.52843735875, 94338.5283073594, 82935.0, 83982.0, 84186.0, 84361.0, 84633.57683211545, 9514.636374468882, 9586.616535338508, 9636.024149493243, 9686.225101991964, 9821.22832636435, 50463.49536504735, 51541.0, 52173.0, 52281.47718522766, 53579.19631205457, 58315.0, 72831.27168728245, 72872.27127728655, 75653.62173189099, 79189.0, 11214.943925280648, 11467.369294688539, 12060.638180854588, 12230.816537751763, 13032.934835325763, 12740.554080607135, 15130.924345378202, 15370.84629153739, 15425.768613471031, 15727.0, 13091.0, 13336.266505341911, 14482.203478808766, 14493.347799348843, 14670.33983470725, 13978.720425591227, 14507.0, 14572.85427145715, 15004.549863504113, 15429.537113886601, 13201.405936733063, 13415.664608384868, 13498.865011350154, 13901.0964287321, 14457.27713614336, 10990.340579564932, 11137.0, 11227.49476273586, 11491.8276225855, 11542.769144617228, 10771.81657271203, 11205.943970280096, 11445.484953177294, 11507.827382589101, 11543.134264930331], "value": 7599.870580563266, "unit": "score"}], "name": "dromaeo_css", "value": 7306.151032372038, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 105.0, 110.0, 110.0, 109.0, 110.0, 111.0, 109.0, 111.0, 109.0], "value": 109.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 126.0, 131.0, 180.0, 127.0, 124.0, 153.0, 125.0, 169.0, 124.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 161.0, 159.0, 160.0, 160.0, 164.0, 161.0, 161.0, 160.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 116.0, 75.0, 75.0, 75.0, 73.0, 97.0, 74.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 111.0, 84.0, 85.0, 84.0, 123.0, 84.0, 85.0, 124.0], "value": 94.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 145.0, 145.0, 145.0, 145.0, 145.0, 146.0, 145.0], "value": 145.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 54.0, 51.0, 54.0, 52.0, 53.0, 52.0, 52.0], "value": 52.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 61.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0, 61.0], "value": 61.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 85.0, 80.0, 82.0, 81.0, 80.0, 82.0, 114.0, 81.0], "value": 84.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 124.0, 127.0, 126.0, 128.0, 120.0, 130.0, 123.0, 146.0, 123.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 163.0, 167.0, 161.0, 160.0, 170.0, 160.0, 161.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 63.0, 63.0, 62.0, 64.0, 64.0, 61.0, 66.0, 62.0, 62.0], "value": 63.4, "unit": "score"}], "name": "kraken", "value": 1496.8999999999999, "alertThreshold": 2.0}]} 03:25:16 INFO - Return code: 0 03:25:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:25:16 ERROR - # TBPL SUCCESS # 03:25:16 INFO - Running post-action listener: _resource_record_post_action 03:25:16 INFO - ##### 03:25:16 INFO - ##### Finished run-tests step (success) 03:25:16 INFO - ##### 03:25:16 INFO - Running post-run listener: _resource_record_post_run 03:25:16 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 543846400; Read time: 0; Write time: 405536 03:25:16 INFO - TinderboxPrint: CPU usage
13.1% 03:25:16 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 03:25:16 INFO - TinderboxPrint: I/O write bytes / time
543,846,400 / 405,536 03:25:16 INFO - TinderboxPrint: CPU idle
8,262.4 (86.8%) 03:25:16 INFO - TinderboxPrint: CPU user
1,208.7 (12.7%) 03:25:16 INFO - TinderboxPrint: Swap in / out
0 / 0 03:25:16 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 248201216; Read time: 0; Write time: 193556 03:25:16 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295059456; Read time: 0; Write time: 211972 03:25:17 INFO - Running post-run listener: _upload_blobber_files 03:25:17 INFO - Blob upload gear active. 03:25:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:25:17 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 03:25:17 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'] 03:25:17 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 03:25:17 INFO - (blobuploader) - INFO - Open directory for files ... 03:25:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:25:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:25:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:18 INFO - (blobuploader) - INFO - Done attempting. 03:25:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:25:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:19 INFO - (blobuploader) - INFO - Done attempting. 03:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:25:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:25:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:25:24 INFO - (blobuploader) - INFO - Done attempting. 03:25:24 INFO - (blobuploader) - INFO - Iteration through files over. 03:25:24 INFO - Return code: 0 03:25:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:25:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:25:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26d9db942eefa99daa6cb4db1370a78eb1c34e13c05670c7d38caece25766328cd09bd80f57f32d102a4ce840f2607dea4d7aa172bd114a9c3e677b503ea94b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcedab1166d6c2cee4cd472826e5951cc010e7227ab28186766de1bf28624875be43e315fd5495ff692eb797c0767ae6c552cdd5fc5111ab8c75d5681d37bd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8a2c93d190aa5aabbd0b739ee92ba03181d5183ad614630f06164f99b4521730f1b78767ccffce80ed5162b35b49801ed5ab83d6838f1bc2d228a7044ecc42"} 03:25:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:25:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:25:24 INFO - Contents: 03:25:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26d9db942eefa99daa6cb4db1370a78eb1c34e13c05670c7d38caece25766328cd09bd80f57f32d102a4ce840f2607dea4d7aa172bd114a9c3e677b503ea94b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcedab1166d6c2cee4cd472826e5951cc010e7227ab28186766de1bf28624875be43e315fd5495ff692eb797c0767ae6c552cdd5fc5111ab8c75d5681d37bd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8a2c93d190aa5aabbd0b739ee92ba03181d5183ad614630f06164f99b4521730f1b78767ccffce80ed5162b35b49801ed5ab83d6838f1bc2d228a7044ecc42"} 03:25:24 INFO - Running post-run listener: copy_logs_to_upload_dir 03:25:24 INFO - Copying logs to upload dir... 03:25:24 INFO - mkdir: /builds/slave/test/build/upload/logs 03:25:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.468467 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-06-07 03:25:24.057700) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:25:24.060888) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 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/f26d9db942eefa99daa6cb4db1370a78eb1c34e13c05670c7d38caece25766328cd09bd80f57f32d102a4ce840f2607dea4d7aa172bd114a9c3e677b503ea94b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcedab1166d6c2cee4cd472826e5951cc010e7227ab28186766de1bf28624875be43e315fd5495ff692eb797c0767ae6c552cdd5fc5111ab8c75d5681d37bd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8a2c93d190aa5aabbd0b739ee92ba03181d5183ad614630f06164f99b4521730f1b78767ccffce80ed5162b35b49801ed5ab83d6838f1bc2d228a7044ecc42"} build_url:https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011343 build_url: 'https://queue.taskcluster.net/v1/task/dqdwaGXERaSU8rT9XRr1mw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f26d9db942eefa99daa6cb4db1370a78eb1c34e13c05670c7d38caece25766328cd09bd80f57f32d102a4ce840f2607dea4d7aa172bd114a9c3e677b503ea94b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/dbcedab1166d6c2cee4cd472826e5951cc010e7227ab28186766de1bf28624875be43e315fd5495ff692eb797c0767ae6c552cdd5fc5111ab8c75d5681d37bd4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/af8a2c93d190aa5aabbd0b739ee92ba03181d5183ad614630f06164f99b4521730f1b78767ccffce80ed5162b35b49801ed5ab83d6838f1bc2d228a7044ecc42"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 03:25:24.089494) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:25:24.089862) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1465293887.464780-202863223 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004481 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 03:25:24.170469) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:25:24.170779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 03:25:24.171058) ========= ========= Total master_lag: 0.18 =========