builder: fx-team_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-065 starttime: 1465215614.6 results: success (0) buildid: 20160606023017 builduid: 50c16143107247e9b93adb79d5a30ca1 revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.598381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.599500) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.599890) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.625555) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.626046) ========= 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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-06 05:20:16-- 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% 37.8M=0s 2016-06-06 05:20:16 (37.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114247 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.755734) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.756055) ========= 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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017690 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.809727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:14.810304) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev a48604c3b4956734c5cae80d350f7890eb9d4aa2 --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 a48604c3b4956734c5cae80d350f7890eb9d4aa2 --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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-06 05:20:16,244 truncating revision to first 12 chars 2016-06-06 05:20:16,244 Setting DEBUG logging. 2016-06-06 05:20:16,244 attempt 1/10 2016-06-06 05:20:16,244 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/a48604c3b495?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-06 05:20:16,603 unpacking tar archive at: fx-team-a48604c3b495/testing/mozharness/ program finished with exit code 0 elapsedTime=0.691073 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:15.521010) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:15.521514) ========= script_repo_revision: a48604c3b4956734c5cae80d350f7890eb9d4aa2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:15.522634) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:15.523374) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-06 05:20:15.537654) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 05:20:15.538000) ========= /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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:20:17 INFO - MultiFileLogger online at 20160606 05:20:17 in /builds/slave/test 05:20:17 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 05:20:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:20:17 INFO - {'append_to_log': False, 05:20:17 INFO - 'base_work_dir': '/builds/slave/test', 05:20:17 INFO - 'blob_upload_branch': 'Fx-Team', 05:20:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:20:17 INFO - 'branch': 'Fx-Team', 05:20:17 INFO - 'buildbot_json_path': 'buildprops.json', 05:20:17 INFO - 'config_files': ('talos/linux_config.py',), 05:20:17 INFO - 'default_actions': ('clobber', 05:20:17 INFO - 'read-buildbot-config', 05:20:17 INFO - 'download-and-extract', 05:20:17 INFO - 'populate-webroot', 05:20:17 INFO - 'create-virtualenv', 05:20:17 INFO - 'install', 05:20:17 INFO - 'run-tests'), 05:20:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:20:17 INFO - 'download_minidump_stackwalk': True, 05:20:17 INFO - 'download_symbols': 'ondemand', 05:20:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:20:17 INFO - 'tooltool.py': '/tools/tooltool.py', 05:20:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:20:17 INFO - '/tools/misc-python/virtualenv.py')}, 05:20:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:20:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:20:17 INFO - 'installer_path': 'installer.exe', 05:20:17 INFO - 'log_level': 'info', 05:20:17 INFO - 'log_name': 'talos', 05:20:17 INFO - 'log_to_console': True, 05:20:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:20:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:20:17 INFO - 'opt_config_files': (), 05:20:17 INFO - 'pip_index': False, 05:20:17 INFO - 'sps_profile': False, 05:20:17 INFO - 'sps_profile_interval': 0, 05:20:17 INFO - 'suite': 'dromaeojs', 05:20:17 INFO - 'system_bits': '32', 05:20:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:20:17 INFO - 'title': 'talos-linux64-ix-065', 05:20:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:20:17 INFO - 'use_talos_json': True, 05:20:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:20:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:20:17 INFO - 'work_dir': 'build'} 05:20:17 INFO - ##### 05:20:17 INFO - ##### Running clobber step. 05:20:17 INFO - ##### 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: clobber 05:20:17 INFO - rmtree: /builds/slave/test/build 05:20:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:20:17 INFO - Running post-action listener: _resource_record_post_action 05:20:17 INFO - ##### 05:20:17 INFO - ##### Finished clobber step (success) 05:20:17 INFO - ##### 05:20:17 INFO - ##### 05:20:17 INFO - ##### Running read-buildbot-config step. 05:20:17 INFO - ##### 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: read_buildbot_config 05:20:17 INFO - Using buildbot properties: 05:20:17 INFO - { 05:20:17 INFO - "project": "", 05:20:17 INFO - "product": "firefox", 05:20:17 INFO - "script_repo_revision": "production", 05:20:17 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 05:20:17 INFO - "repository": "", 05:20:17 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs", 05:20:17 INFO - "buildid": "20160606023017", 05:20:17 INFO - "pgo_build": "True", 05:20:17 INFO - "basedir": "/builds/slave/test", 05:20:17 INFO - "buildnumber": 1226, 05:20:17 INFO - "slavename": "talos-linux64-ix-065", 05:20:17 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:20:17 INFO - "platform": "ubuntu64_hw", 05:20:17 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 05:20:17 INFO - "branch": "fx-team", 05:20:17 INFO - "repo_path": "integration/fx-team", 05:20:17 INFO - "revision": "a48604c3b4956734c5cae80d350f7890eb9d4aa2", 05:20:17 INFO - "stage_platform": "linux64-pgo", 05:20:17 INFO - "builduid": "50c16143107247e9b93adb79d5a30ca1", 05:20:17 INFO - "slavebuilddir": "test" 05:20:17 INFO - } 05:20:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 05:20:17 INFO - Running post-action listener: _resource_record_post_action 05:20:17 INFO - ##### 05:20:17 INFO - ##### Finished read-buildbot-config step (success) 05:20:17 INFO - ##### 05:20:17 INFO - ##### 05:20:17 INFO - ##### Running download-and-extract step. 05:20:17 INFO - ##### 05:20:17 INFO - Running pre-action listener: _resource_record_pre_action 05:20:17 INFO - Running main action method: download_and_extract 05:20:17 INFO - mkdir: /builds/slave/test/build/tests 05:20: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')]} 05:20:17 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 05:20:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 05:20:18 INFO - Downloaded 1361 bytes. 05:20:18 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 05:20:18 INFO - Using the following test package requirements: 05:20:18 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:18 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:20:18 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 05:20:18 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'jsshell-linux-x86_64.zip'], 05:20:18 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:20:18 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 05:20:18 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:20:18 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:20:18 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:20:18 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 05:20:18 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:20:18 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:20:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:18 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:24 INFO - Downloaded 24440907 bytes. 05:20:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:26 INFO - Return code: 0 05:20:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:20:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:26 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:20:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 05:20:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 05:20:27 INFO - Downloaded 24440907 bytes. 05:20:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 05:20:28 INFO - Return code: 0 05:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:28 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:20:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 05:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 05:20:29 INFO - Downloaded 10833369 bytes. 05:20:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:20:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 05:20:30 INFO - Return code: 0 05:20:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:30 INFO - https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:20:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 05:20:31 INFO - Downloaded 59189488 bytes. 05:20:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:31 INFO - mkdir: /builds/slave/test/properties 05:20:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:20:31 INFO - Writing to file /builds/slave/test/properties/build_url 05:20:31 INFO - Contents: 05:20:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 05:20:32 INFO - Running post-action listener: _resource_record_post_action 05:20:32 INFO - Running post-action listener: set_extra_try_arguments 05:20:32 INFO - ##### 05:20:32 INFO - ##### Finished download-and-extract step (success) 05:20:32 INFO - ##### 05:20:32 INFO - ##### 05:20:32 INFO - ##### Running populate-webroot step. 05:20:32 INFO - ##### 05:20:32 INFO - Running pre-action listener: _resource_record_pre_action 05:20:32 INFO - Running main action method: populate_webroot 05:20:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:20:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:20:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:20:32 INFO - '--tppagecycles', 05:20:32 INFO - '7'], 05:20:32 INFO - 'tests': ['tsvgm']}}, 05:20:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:20:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:20:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:20:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:20:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:20:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['damp', 'tps']}, 05:20:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'tests': ['damp', 'tps']}, 05:20:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['dromaeo_dom']}, 05:20:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:20:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'other-e10s': {'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['a11yr', 05:20:32 INFO - 'ts_paint', 05:20:32 INFO - 'tpaint', 05:20:32 INFO - 'sessionrestore', 05:20:32 INFO - 'sessionrestore_no_auto_restore', 05:20:32 INFO - 'tabpaint']}, 05:20:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['tsvgx', 05:20:32 INFO - 'tsvgr_opacity', 05:20:32 INFO - 'tart', 05:20:32 INFO - 'tscrollx', 05:20:32 INFO - 'cart']}, 05:20:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:20:32 INFO - 'tsvgr_opacity', 05:20:32 INFO - 'tart', 05:20:32 INFO - 'tscrollx', 05:20:32 INFO - 'cart']}, 05:20:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'talos_options': ['--disable-e10s'], 05:20:32 INFO - 'tests': ['tp5o']}, 05:20:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'tests': ['tp5o']}, 05:20:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'talos_options': ['--disable-e10s', 05:20:32 INFO - '--xperf_path', 05:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:32 INFO - 'tests': ['tp5n']}, 05:20:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:20:32 INFO - 'talos_options': ['--xperf_path', 05:20:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:20:32 INFO - 'tests': ['tp5n']}}, 05:20:32 INFO - 'talos.zip': {'path': '', 05:20:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:20:32 INFO - Running post-action listener: _resource_record_post_action 05:20:32 INFO - ##### 05:20:32 INFO - ##### Finished populate-webroot step (success) 05:20:32 INFO - ##### 05:20:32 INFO - ##### 05:20:32 INFO - ##### Running create-virtualenv step. 05:20:32 INFO - ##### 05:20:32 INFO - Running pre-action listener: _resource_record_pre_action 05:20:32 INFO - Running main action method: create_virtualenv 05:20:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:20:32 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 05:20:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:20:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:20:32 INFO - Using real prefix '/usr' 05:20:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:20:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:20:34 INFO - Installing pip.................done. 05:20:34 INFO - Return code: 0 05:20:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:20:34 INFO - Using env: {'DISPLAY': ':0', 05:20:34 INFO - 'HOME': '/home/cltbld', 05:20:34 INFO - 'LANG': 'en_US.UTF-8', 05:20:34 INFO - 'LANGUAGE': 'en_US:en', 05:20:34 INFO - 'LOGNAME': 'cltbld', 05:20:34 INFO - 'MAIL': '/var/mail/cltbld', 05:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:34 INFO - 'MOZ_NO_REMOTE': '1', 05:20:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:34 INFO - 'NO_EM_RESTART': '1', 05:20:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:34 INFO - 'PWD': '/builds/slave/test', 05:20:34 INFO - 'SHELL': '/bin/bash', 05:20:34 INFO - 'SHLVL': '1', 05:20:34 INFO - 'TERM': 'linux', 05:20:34 INFO - 'TMOUT': '86400', 05:20:34 INFO - 'USER': 'cltbld', 05:20:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:34 INFO - '_': '/tools/buildbot/bin/python'} 05:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:35 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 05:20:35 INFO - Cleaning up... 05:20:35 INFO - Return code: 0 05:20:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:35 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:35 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 05:20:35 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 05:20:35 INFO - Using env: {'DISPLAY': ':0', 05:20:35 INFO - 'HOME': '/home/cltbld', 05:20:35 INFO - 'LANG': 'en_US.UTF-8', 05:20:35 INFO - 'LANGUAGE': 'en_US:en', 05:20:35 INFO - 'LOGNAME': 'cltbld', 05:20:35 INFO - 'MAIL': '/var/mail/cltbld', 05:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:35 INFO - 'MOZ_NO_REMOTE': '1', 05:20:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:35 INFO - 'NO_EM_RESTART': '1', 05:20:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:35 INFO - 'PWD': '/builds/slave/test', 05:20:35 INFO - 'SHELL': '/bin/bash', 05:20:35 INFO - 'SHLVL': '1', 05:20:35 INFO - 'TERM': 'linux', 05:20:35 INFO - 'TMOUT': '86400', 05:20:35 INFO - 'USER': 'cltbld', 05:20:35 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:35 INFO - '_': '/tools/buildbot/bin/python'} 05:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:35 INFO - Downloading/unpacking psutil>=3.1.1 05:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:20:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:37 INFO - Installing collected packages: psutil 05:20:37 INFO - Running setup.py install for psutil 05:20:37 INFO - building 'psutil._psutil_linux' extension 05:20:37 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 05:20:37 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 05:20:37 INFO - building 'psutil._psutil_posix' extension 05:20:37 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 05:20:37 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 05:20:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:20:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:20:37 INFO - Successfully installed psutil 05:20:37 INFO - Cleaning up... 05:20:37 INFO - Return code: 0 05:20:37 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:20:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:20:37 INFO - Using env: {'DISPLAY': ':0', 05:20:37 INFO - 'HOME': '/home/cltbld', 05:20:37 INFO - 'LANG': 'en_US.UTF-8', 05:20:37 INFO - 'LANGUAGE': 'en_US:en', 05:20:37 INFO - 'LOGNAME': 'cltbld', 05:20:37 INFO - 'MAIL': '/var/mail/cltbld', 05:20:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:37 INFO - 'MOZ_NO_REMOTE': '1', 05:20:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:37 INFO - 'NO_EM_RESTART': '1', 05:20:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:37 INFO - 'PWD': '/builds/slave/test', 05:20:37 INFO - 'SHELL': '/bin/bash', 05:20:37 INFO - 'SHLVL': '1', 05:20:37 INFO - 'TERM': 'linux', 05:20:37 INFO - 'TMOUT': '86400', 05:20:37 INFO - 'USER': 'cltbld', 05:20:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:37 INFO - '_': '/tools/buildbot/bin/python'} 05:20:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:20:38 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 05:20:38 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 05:20:38 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 05:20:38 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 05:20:38 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 05:20:38 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 05:20:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:20:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:20:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:20:40 INFO - Installing collected packages: mozsystemmonitor 05:20:40 INFO - Running setup.py install for mozsystemmonitor 05:20:40 INFO - Successfully installed mozsystemmonitor 05:20:40 INFO - Cleaning up... 05:20:40 INFO - Return code: 0 05:20:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:20:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:20:40 INFO - Using env: {'DISPLAY': ':0', 05:20:40 INFO - 'HOME': '/home/cltbld', 05:20:40 INFO - 'LANG': 'en_US.UTF-8', 05:20:40 INFO - 'LANGUAGE': 'en_US:en', 05:20:40 INFO - 'LOGNAME': 'cltbld', 05:20:40 INFO - 'MAIL': '/var/mail/cltbld', 05:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:40 INFO - 'MOZ_NO_REMOTE': '1', 05:20:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:40 INFO - 'NO_EM_RESTART': '1', 05:20:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:40 INFO - 'PWD': '/builds/slave/test', 05:20:40 INFO - 'SHELL': '/bin/bash', 05:20:40 INFO - 'SHLVL': '1', 05:20:40 INFO - 'TERM': 'linux', 05:20:40 INFO - 'TMOUT': '86400', 05:20:40 INFO - 'USER': 'cltbld', 05:20:40 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:40 INFO - '_': '/tools/buildbot/bin/python'} 05:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:40 INFO - Downloading/unpacking jsonschema==2.5.1 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:40 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 05:20:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:20:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:20:42 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 05:20:42 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 05:20:42 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 05:20:42 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 05:20:42 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 05:20:42 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 05:20:42 INFO - Downloading functools32-3.2.3-2.tar.gz 05:20:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:20:42 INFO - warning: no files found matching '*.txt' 05:20:42 INFO - no previously-included directories found matching 'build' 05:20:42 INFO - no previously-included directories found matching 'dist' 05:20:42 INFO - no previously-included directories found matching '.git*' 05:20:42 INFO - Installing collected packages: jsonschema, functools32 05:20:42 INFO - Running setup.py install for functools32 05:20:42 INFO - warning: no files found matching '*.txt' 05:20:42 INFO - no previously-included directories found matching 'build' 05:20:42 INFO - no previously-included directories found matching 'dist' 05:20:42 INFO - no previously-included directories found matching '.git*' 05:20:42 INFO - Successfully installed jsonschema functools32 05:20:42 INFO - Cleaning up... 05:20:42 INFO - Return code: 0 05:20:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:42 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:42 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 05:20:42 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 05:20:42 INFO - Using env: {'DISPLAY': ':0', 05:20:42 INFO - 'HOME': '/home/cltbld', 05:20:42 INFO - 'LANG': 'en_US.UTF-8', 05:20:42 INFO - 'LANGUAGE': 'en_US:en', 05:20:42 INFO - 'LOGNAME': 'cltbld', 05:20:42 INFO - 'MAIL': '/var/mail/cltbld', 05:20:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:42 INFO - 'MOZ_NO_REMOTE': '1', 05:20:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:42 INFO - 'NO_EM_RESTART': '1', 05:20:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:42 INFO - 'PWD': '/builds/slave/test', 05:20:42 INFO - 'SHELL': '/bin/bash', 05:20:42 INFO - 'SHLVL': '1', 05:20:42 INFO - 'TERM': 'linux', 05:20:42 INFO - 'TMOUT': '86400', 05:20:42 INFO - 'USER': 'cltbld', 05:20:42 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:42 INFO - '_': '/tools/buildbot/bin/python'} 05:20:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:43 INFO - Downloading/unpacking blobuploader==1.2.4 05:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:44 INFO - Downloading blobuploader-1.2.4.tar.gz 05:20:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:20:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:20:44 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 05:20:44 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 05:20:44 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 05:20:44 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 05:20:44 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 05:20:44 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 05:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:20:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:45 INFO - Downloading docopt-0.6.1.tar.gz 05:20:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:20:45 INFO - Installing collected packages: blobuploader, requests, docopt 05:20:45 INFO - Running setup.py install for blobuploader 05:20:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:20:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:20:45 INFO - Running setup.py install for requests 05:20:46 INFO - Running setup.py install for docopt 05:20:46 INFO - Successfully installed blobuploader requests docopt 05:20:46 INFO - Cleaning up... 05:20:46 INFO - Return code: 0 05:20:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:46 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:46 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 05:20:46 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 05:20:46 INFO - Using env: {'DISPLAY': ':0', 05:20:46 INFO - 'HOME': '/home/cltbld', 05:20:46 INFO - 'LANG': 'en_US.UTF-8', 05:20:46 INFO - 'LANGUAGE': 'en_US:en', 05:20:46 INFO - 'LOGNAME': 'cltbld', 05:20:46 INFO - 'MAIL': '/var/mail/cltbld', 05:20:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:46 INFO - 'MOZ_NO_REMOTE': '1', 05:20:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:46 INFO - 'NO_EM_RESTART': '1', 05:20:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:46 INFO - 'PWD': '/builds/slave/test', 05:20:46 INFO - 'SHELL': '/bin/bash', 05:20:46 INFO - 'SHLVL': '1', 05:20:46 INFO - 'TERM': 'linux', 05:20:46 INFO - 'TMOUT': '86400', 05:20:46 INFO - 'USER': 'cltbld', 05:20:46 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:46 INFO - '_': '/tools/buildbot/bin/python'} 05:20:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:46 INFO - Running setup.py (path:/tmp/pip-vLkFY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:46 INFO - Running setup.py (path:/tmp/pip-hgp6V5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:46 INFO - Running setup.py (path:/tmp/pip-jTCQ3f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:46 INFO - Running setup.py (path:/tmp/pip-IWhffv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:46 INFO - Running setup.py (path:/tmp/pip-SgiEtg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:46 INFO - Running setup.py (path:/tmp/pip-a7yH_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:46 INFO - Running setup.py (path:/tmp/pip-11Axnb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:47 INFO - Running setup.py (path:/tmp/pip-QIi5cN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:47 INFO - Running setup.py (path:/tmp/pip-wmZQvr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:47 INFO - Running setup.py (path:/tmp/pip-JEfNQW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:47 INFO - Running setup.py (path:/tmp/pip-Oip5_Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:47 INFO - Running setup.py (path:/tmp/pip-G5I5NZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:47 INFO - Running setup.py (path:/tmp/pip-ChGGn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:47 INFO - Running setup.py (path:/tmp/pip-IA1DgT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:47 INFO - Running setup.py (path:/tmp/pip-lkdNe1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:47 INFO - Running setup.py (path:/tmp/pip-U4PxO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:47 INFO - Running setup.py (path:/tmp/pip-zrub86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:20:47 INFO - Running setup.py install for manifestparser 05:20:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:20:47 INFO - Running setup.py install for mozcrash 05:20:47 INFO - Running setup.py install for mozdebug 05:20:48 INFO - Running setup.py install for mozdevice 05:20:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozfile 05:20:48 INFO - Running setup.py install for mozhttpd 05:20:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozinfo 05:20:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozInstall 05:20:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozleak 05:20:48 INFO - Running setup.py install for mozlog 05:20:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for moznetwork 05:20:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:20:48 INFO - Running setup.py install for mozprocess 05:20:49 INFO - Running setup.py install for mozprofile 05:20:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:20:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:20:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:20:49 INFO - Running setup.py install for mozrunner 05:20:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:20:49 INFO - Running setup.py install for mozscreenshot 05:20:49 INFO - Running setup.py install for moztest 05:20:49 INFO - Running setup.py install for mozversion 05:20:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:20:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:20:49 INFO - Cleaning up... 05:20:49 INFO - Return code: 0 05:20:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:49 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:49 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 05:20:49 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 05:20:49 INFO - Using env: {'DISPLAY': ':0', 05:20:49 INFO - 'HOME': '/home/cltbld', 05:20:49 INFO - 'LANG': 'en_US.UTF-8', 05:20:49 INFO - 'LANGUAGE': 'en_US:en', 05:20:49 INFO - 'LOGNAME': 'cltbld', 05:20:49 INFO - 'MAIL': '/var/mail/cltbld', 05:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:49 INFO - 'MOZ_NO_REMOTE': '1', 05:20:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:49 INFO - 'NO_EM_RESTART': '1', 05:20:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:49 INFO - 'PWD': '/builds/slave/test', 05:20:49 INFO - 'SHELL': '/bin/bash', 05:20:49 INFO - 'SHLVL': '1', 05:20:49 INFO - 'TERM': 'linux', 05:20:49 INFO - 'TMOUT': '86400', 05:20:49 INFO - 'USER': 'cltbld', 05:20:49 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:49 INFO - '_': '/tools/buildbot/bin/python'} 05:20:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:20:49 INFO - Running setup.py (path:/tmp/pip-QOQ0fc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:20:49 INFO - Running setup.py (path:/tmp/pip-zJT3P6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:20:49 INFO - Running setup.py (path:/tmp/pip-XwMOtZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:20:49 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)) 05:20:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:20:50 INFO - Running setup.py (path:/tmp/pip-FMgaNt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:20:50 INFO - Running setup.py (path:/tmp/pip-I4Nnir-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:20:50 INFO - Running setup.py (path:/tmp/pip-9CPvJh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:20:50 INFO - Running setup.py (path:/tmp/pip-2U910l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:20:50 INFO - Running setup.py (path:/tmp/pip-HI6PzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:20:50 INFO - Running setup.py (path:/tmp/pip-lDuYf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:20:50 INFO - Running setup.py (path:/tmp/pip-JeNUbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:20:50 INFO - Running setup.py (path:/tmp/pip-1zFu43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:20:50 INFO - Running setup.py (path:/tmp/pip-I_u2S5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:20:50 INFO - Running setup.py (path:/tmp/pip-1yhxgf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:20:50 INFO - Running setup.py (path:/tmp/pip-QqcsQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:50 INFO - Running setup.py (path:/tmp/pip-tN0WKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:20:50 INFO - Running setup.py (path:/tmp/pip-nOi48X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:20:50 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)) 05:20:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:20:50 INFO - Running setup.py (path:/tmp/pip-jGjYC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:20:51 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)) 05:20:51 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)) 05:20:51 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)) 05:20:51 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)) 05:20:51 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)) 05:20:51 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)) 05:20:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:52 INFO - Downloading blessings-1.6.tar.gz 05:20:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:20:53 INFO - Installing collected packages: blessings 05:20:53 INFO - Running setup.py install for blessings 05:20:53 INFO - Successfully installed blessings 05:20:53 INFO - Cleaning up... 05:20:53 INFO - Return code: 0 05:20:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:20:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:53 INFO - Reading from file tmpfile_stdout 05:20:53 INFO - Current package versions: 05:20:53 INFO - argparse == 1.2.1 05:20:53 INFO - blessings == 1.6 05:20:53 INFO - blobuploader == 1.2.4 05:20:53 INFO - docopt == 0.6.1 05:20:53 INFO - functools32 == 3.2.3-2 05:20:53 INFO - jsonschema == 2.5.1 05:20:53 INFO - manifestparser == 1.1 05:20:53 INFO - mozInstall == 1.12 05:20:53 INFO - mozcrash == 0.17 05:20:53 INFO - mozdebug == 0.1 05:20:53 INFO - mozdevice == 0.48 05:20:53 INFO - mozfile == 1.2 05:20:53 INFO - mozhttpd == 0.7 05:20:53 INFO - mozinfo == 0.9 05:20:53 INFO - mozleak == 0.1 05:20:53 INFO - mozlog == 3.2 05:20:53 INFO - moznetwork == 0.27 05:20:53 INFO - mozprocess == 0.22 05:20:53 INFO - mozprofile == 0.28 05:20:53 INFO - mozrunner == 6.11 05:20:53 INFO - mozscreenshot == 0.1 05:20:53 INFO - mozsystemmonitor == 0.3 05:20:53 INFO - moztest == 0.7 05:20:53 INFO - mozversion == 1.4 05:20:53 INFO - psutil == 3.1.1 05:20:53 INFO - requests == 1.2.3 05:20:53 INFO - wsgiref == 0.1.2 05:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:53 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 05:20:53 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 05:20:53 INFO - Using env: {'DISPLAY': ':0', 05:20:53 INFO - 'HOME': '/home/cltbld', 05:20:53 INFO - 'LANG': 'en_US.UTF-8', 05:20:53 INFO - 'LANGUAGE': 'en_US:en', 05:20:53 INFO - 'LOGNAME': 'cltbld', 05:20:53 INFO - 'MAIL': '/var/mail/cltbld', 05:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:53 INFO - 'MOZ_NO_REMOTE': '1', 05:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:53 INFO - 'NO_EM_RESTART': '1', 05:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:53 INFO - 'PWD': '/builds/slave/test', 05:20:53 INFO - 'SHELL': '/bin/bash', 05:20:53 INFO - 'SHLVL': '1', 05:20:53 INFO - 'TERM': 'linux', 05:20:53 INFO - 'TMOUT': '86400', 05:20:53 INFO - 'USER': 'cltbld', 05:20:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:53 INFO - '_': '/tools/buildbot/bin/python'} 05:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 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)) 05:20:53 INFO - Cleaning up... 05:20:53 INFO - Return code: 0 05:20:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:20: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')]} 05:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20: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')]} 05:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:53 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 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:53 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 05:20:53 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 05:20:53 INFO - Using env: {'DISPLAY': ':0', 05:20:53 INFO - 'HOME': '/home/cltbld', 05:20:53 INFO - 'LANG': 'en_US.UTF-8', 05:20:53 INFO - 'LANGUAGE': 'en_US:en', 05:20:53 INFO - 'LOGNAME': 'cltbld', 05:20:53 INFO - 'MAIL': '/var/mail/cltbld', 05:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:53 INFO - 'MOZ_NO_REMOTE': '1', 05:20:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:53 INFO - 'NO_EM_RESTART': '1', 05:20:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:53 INFO - 'PWD': '/builds/slave/test', 05:20:53 INFO - 'SHELL': '/bin/bash', 05:20:53 INFO - 'SHLVL': '1', 05:20:53 INFO - 'TERM': 'linux', 05:20:53 INFO - 'TMOUT': '86400', 05:20:53 INFO - 'USER': 'cltbld', 05:20:53 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:53 INFO - '_': '/tools/buildbot/bin/python'} 05:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:20:54 INFO - Cleaning up... 05:20:54 INFO - Return code: 0 05:20:54 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:20:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f50ae26df10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c350>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, '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': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', '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 05:20:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:20:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:20:54 INFO - Using env: {'DISPLAY': ':0', 05:20:54 INFO - 'HOME': '/home/cltbld', 05:20:54 INFO - 'LANG': 'en_US.UTF-8', 05:20:54 INFO - 'LANGUAGE': 'en_US:en', 05:20:54 INFO - 'LOGNAME': 'cltbld', 05:20:54 INFO - 'MAIL': '/var/mail/cltbld', 05:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:20:54 INFO - 'MOZ_NO_REMOTE': '1', 05:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:20:54 INFO - 'NO_EM_RESTART': '1', 05:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:20:54 INFO - 'PWD': '/builds/slave/test', 05:20:54 INFO - 'SHELL': '/bin/bash', 05:20:54 INFO - 'SHLVL': '1', 05:20:54 INFO - 'TERM': 'linux', 05:20:54 INFO - 'TMOUT': '86400', 05:20:54 INFO - 'USER': 'cltbld', 05:20:54 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:20:54 INFO - '_': '/tools/buildbot/bin/python'} 05:20:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:20:54 INFO - Downloading/unpacking flake8 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:20:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:20:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:20:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:56 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:56 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:56 INFO - no previously-included directories found matching 'docs/_build' 05:20:56 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:20:57 INFO - Running setup.py install for pep8 05:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:20:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:20:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:20:57 INFO - no previously-included directories found matching 'docs/_build' 05:20:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:20:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:20:57 INFO - Cleaning up... 05:20:57 INFO - Return code: 0 05:20:57 INFO - Running post-action listener: _resource_record_post_action 05:20:57 INFO - Running post-action listener: _start_resource_monitoring 05:20:57 INFO - Starting resource monitoring. 05:20:57 INFO - ##### 05:20:57 INFO - ##### Finished create-virtualenv step (success) 05:20:57 INFO - ##### 05:20:57 INFO - ##### 05:20:57 INFO - ##### Running install step. 05:20:57 INFO - ##### 05:20:57 INFO - Running pre-action listener: _resource_record_pre_action 05:20:57 INFO - Running main action method: install 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:20:57 INFO - Reading from file tmpfile_stdout 05:20:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:20:57 INFO - Reading from file tmpfile_stdout 05:20:57 INFO - Output received: 05:20:57 INFO - Usage: mozinstall [options] installer 05:20:57 INFO - Options: 05:20:57 INFO - -h, --help show this help message and exit 05:20:57 INFO - -d DEST, --destination=DEST 05:20:57 INFO - Directory to install application into. [default: 05:20:57 INFO - "/builds/slave/test"] 05:20:57 INFO - --app=APP Application being installed. [default: firefox] 05:20:57 INFO - mkdir: /builds/slave/test/build/application 05:20:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:20:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 05:21:14 INFO - Reading from file tmpfile_stdout 05:21:14 INFO - Output received: 05:21:14 INFO - /builds/slave/test/build/application/firefox/firefox 05:21:14 INFO - Running post-action listener: _resource_record_post_action 05:21:14 INFO - ##### 05:21:14 INFO - ##### Finished install step (success) 05:21:14 INFO - ##### 05:21:14 INFO - ##### 05:21:14 INFO - ##### Running run-tests step. 05:21:14 INFO - ##### 05:21:14 INFO - Running pre-action listener: _resource_record_pre_action 05:21:14 INFO - Running main action method: run_tests 05:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:21:14 INFO - Python 2.7.3 05:21:14 INFO - Return code: 0 05:21:14 INFO - grabbing minidump binary from tooltool 05:21:14 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')]} 05:21:14 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 0x2c9b1c0>, '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 0x2c9c0c0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c9c550>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:21:14 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 05:21:14 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 05:21:14 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 05:21:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:21:14 INFO - Return code: 0 05:21:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:21:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:21:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:21:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:21:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:21:15 INFO - Return code: 0 05:21:15 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:21:15 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 05:21:15 INFO - Using env: {'DISPLAY': ':0', 05:21:15 INFO - 'HOME': '/home/cltbld', 05:21:15 INFO - 'LANG': 'en_US.UTF-8', 05:21:15 INFO - 'LANGUAGE': 'en_US:en', 05:21:15 INFO - 'LOGNAME': 'cltbld', 05:21:15 INFO - 'MAIL': '/var/mail/cltbld', 05:21:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:21:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:21:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:21:15 INFO - 'MOZ_NO_REMOTE': '1', 05:21:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:21:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:21:15 INFO - 'NO_EM_RESTART': '1', 05:21:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:21:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:21:15 INFO - 'PWD': '/builds/slave/test', 05:21:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:21:15 INFO - 'SHELL': '/bin/bash', 05:21:15 INFO - 'SHLVL': '1', 05:21:15 INFO - 'TERM': 'linux', 05:21:15 INFO - 'TMOUT': '86400', 05:21:15 INFO - 'USER': 'cltbld', 05:21:15 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379', 05:21:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:21:15 INFO - '_': '/tools/buildbot/bin/python'} 05:21:15 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/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 05:21:15 INFO - mozversion application_buildid: 20160606023017 05:21:15 INFO - mozversion application_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:21:15 INFO - mozversion application_display_name: Nightly 05:21:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:21:15 INFO - mozversion application_name: Firefox 05:21:15 INFO - mozversion application_remotingname: firefox 05:21:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:21:15 INFO - mozversion application_vendor: Mozilla 05:21:15 INFO - mozversion application_version: 49.0a1 05:21:15 INFO - mozversion platform_buildid: 20160606023017 05:21:15 INFO - mozversion platform_changeset: a48604c3b4956734c5cae80d350f7890eb9d4aa2 05:21:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:21:15 INFO - mozversion platform_version: 49.0a1 05:21:15 INFO - using testdate: 1465215675 05:21:15 INFO - actual date: 1465215675 05:21:15 INFO - starting webserver on 'localhost:54217' 05:21:15 INFO - SUITE-START | Running 2 tests 05:21:15 INFO - TEST-START | dromaeo_css 05:21:15 INFO - operating with platform_type : linux_ 05:21:15 INFO - Initialising browser for dromaeo_css test... 05:21:15 INFO - TEST-INFO | started process 15241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg6aBhm/profile http://localhost:54217/getInfo.html) 05:21:19 INFO - PROCESS | 15241 | __metrics Screen width/height:1600/1200 05:21:19 INFO - PROCESS | 15241 | colorDepth:24 05:21:19 INFO - PROCESS | 15241 | Browser inner width/height: 1024/697 05:21:19 INFO - PROCESS | 15241 | __metrics 05:21:20 ERROR - PROCESS | 15241 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:21:21 INFO - TEST-INFO | 15241: exit 0 05:21:21 INFO - Browser initialized. 05:21:21 INFO - Running cycle 1/1 for dromaeo_css test... 05:21:21 INFO - TEST-INFO | started process 15321 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpg6aBhm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:21:33 INFO - PROCESS | 15321 | RSS: Main: 156225536 05:21:33 INFO - PROCESS | 15321 | 05:22:24 INFO - PROCESS | 15321 | 1465215744324 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] 05:24:32 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54217/tests/dromaeo/cssquery-ext.html) 05:24:33 INFO - PROCESS | 15321 | RSS: Main: 257748992 05:24:33 INFO - PROCESS | 15321 | 05:27:35 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-ext.html (next: http://localhost:54217/tests/dromaeo/cssquery-jquery.html) 05:27:36 INFO - PROCESS | 15321 | RSS: Main: 247451648 05:27:36 INFO - PROCESS | 15321 | 05:30:38 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54217/tests/dromaeo/cssquery-mootools.html) 05:30:38 INFO - PROCESS | 15321 | RSS: Main: 241917952 05:30:38 INFO - PROCESS | 15321 | 05:33:41 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54217/tests/dromaeo/cssquery-prototype.html) 05:33:41 INFO - PROCESS | 15321 | RSS: Main: 242905088 05:33:41 INFO - PROCESS | 15321 | 05:36:44 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54217/tests/dromaeo/cssquery-yui.html) 05:36:44 INFO - PROCESS | 15321 | RSS: Main: 221888512 05:36:44 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | Cycle 1(1): loaded http://localhost:54217/tests/dromaeo/cssquery-yui.html (next: http://localhost:54217/tests/dromaeo/cssquery-dojo.html) 05:39:47 INFO - PROCESS | 15321 | RSS: Main: 271872000 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | __start_tp_report 05:39:47 INFO - PROCESS | 15321 | _x_x_mozilla_page_load 05:39:47 INFO - PROCESS | 15321 | _x_x_mozilla_page_load_details 05:39:47 INFO - PROCESS | 15321 | |i|pagename|runs| 05:39:47 INFO - PROCESS | 15321 | |0;dojo.html;3108.9067327980156;3121.0636808957315;3132.6240851097864;3143.7170654641077;3167.5565420841085;5294.814681486148;5318.361796584415;5337.252784610153;5376.8118115865955;5418.8916221675545;5383.67697938123;5414.972925135369;5420.105682562373;5420.620556561043;5457.645253058548;4822.493638167985;4893.314935908976;4921.114199444099;4921.311016457699;4983.6013118950395;4911.508849115078;4939.481354457784;4956.2565615157655;4959.776810043539;4975.552200301972;4773.164696178173;4816;4864.027194561084;4878.756062196876;4885.096257192431;4874.098291816025;4895.363602731658;4924.187509061001;4933.7286449245275;4983.551480366785;4695.131400690883;4899.534544218293;4904.6321525885705;4919;4946.480619534969;5173.120569503193;5237.659552129099;5247.711375874325;5289.656172348785;5306.495882891119;5791.623544469596;5828.621139625953;5846.327672317695;5851.268591426072;5858.297004359504;5609.298837645294;5708.600397972144;5830.212921255618;5833.212516310286;5835.153902684087;5364.570834333244;5479.863003424906;5485.61600687952;5486.506214440719;5492.231087647732;5942.970285148546;5969.820905372759;5974.074018527135;5978.910316345258;5982.0727787193055;5477.315335583052;5632;5646.096624540054;5729.341125770589;5744.798932037359;5782.9012487627215;5835.591508594358;5842.211301474332;5853.64878107315;5855.326637436664;5744.770209191669;5762.855928601734;5763.7982670606325;5792.247007888947;5802.767889284466;5535.391106978229;5758.193852860602;5775.422457754275;5808.88382232353;5822.534197264209;4360.520342762294;4363.06194168249;4363.170997510463;4371.431713877176;4397.868063958086;3928.0769019280447;3957.8021098945514;3973.4238535412783;4008.518977722692;4030.536488303824;5308.991291654574;5355.758990845421;5461.590380721462;5488.91766623501;5532.1425179097305;5842.766289348463;5857.824265272048;5858.414158584107;5858.502027327725;5895.29256489224;5558.44415558441;5560.888782224414;5564.582656300794;5565.332160140728;5572.024895643246;4692.1084993851055;4768.61851051915;4788.521147885183;4825.420949486084;4825.758712064383;5959.225300710967;5982.521398288127;5997.100434934795;6002.159697642333;6002.459778619946;5677.063284558001;5764.971175144097;5777;5780.479756821906;5785;5450.264214331173;5925.911111333247;5959.791407300723;6004.729787159676;6017.037274036134;5691.658500489818;5691.743871525874;5696.088625820014;5697.914531281951;5713.885722285448;5513.889722205453;5709.22925405065;5754.9424505754405;5755.510781583444;5764.682942438206;5630.183623374506;5666.951613951433;5674.914876276776;5675.858103547444;5724.141378793214;5620.1288800236025;5661.2923384576925;5668.319801623831;5671.376148623565;5678.3186017678145;5465.508104270476;5482.643628164156;5511.476409741068;5590.692511911884;5591.161325800999;5676.489115979416;5689.175069614966;5703.230063941481;5717.799877004285;5718;5549.500544950974;5558.110702287615;5560.138178582326;5560.749766260447;5562.972185139049 05:39:47 INFO - PROCESS | 15321 | |1;ext.html;599.2030599302927;614.5483069943591;629.3643420145654;634.0299342006729;648.1444493268887;33973.320533589314;34728.826355868216;43260.783696081475;44458.44332453404;44515.77742111285;45961.54038459614;46436;46515;46563.767181164134;46573.06853862921;8676.783080422976;8800.911990880106;8853.026167121612;8881.067487913773;8882.511461869595;8642.913570864304;8715.433496822718;8741.606627701769;8747.781305467382;8774.956125219365;8813.338999575026;8834.911650883474;8857.379983401132;8859.11408859112;8859.778505537348;8719.782005449852;8775.297976161924;8824.911750882537;8830.381873268874;8835.20483156519;8729.563521823884;8804.207621314112;8818.29453643707;8819.691310804155;8827.779305517413;42539.7873010636;42962.35556466624;42977.35533966993;43060.354094688606;43093;3471.409860323751;3722;3722.7394082414244;4107.774072426016;4267.957320426818;31950.20124496883;32462.18844528882;32875;32891;34248.31503369919;4382.298832186867;4434.73391596502;4558.156741002892;4592.908141837178;4597.839075632371;357030;358675;358724;360278;360627;61698.69150654308;61976;62458.37541624616;62504.374956249856;62609.373906261266;65414.67292663506;65507;65710.0286991391;65760.34239657638;65839.34160658428;16815;17102.315907363565;17107.65784684324;17117.486475405756;17123.57191070208;13141.60575182727;13178;13191;13195.274259915604;13199.934000329937;16778.875737503142;18666.906665466857;18805.341813036477;18831.81168188328;19009.524761881064;5599.580031497654;6298.811035668938;6632.071509988606;6673.1992160941;6724.293949135368;934.3226161033197;1092.448313601626;1110.4114819145866;1132.4451019000794;1150.442035612727;32366.676333236835;33043;33053.17367065795;33194.8340258302;33494.3301133976;1104.6630777612745;1119.5913491575516;1136.1478890831877;1149.4540093455541;1276.1003492537739;16849.156254025467;17296.22167002488;17458.214380352914;17485.47543573695;17518.38685645996;543585;548157;549312;550965;553211;57977;58489;58550.12174817381;58629.706851466326;58654.12018819721;1255.9183653062705;1337.237774468563;1398.0982266438293;1413.4557397965384;1417.2276109520337;32424.189395264362;33597.456419690476;33601;33712.66287337095;34375.140621484665;51660.48339516557;51986.22020669769;52122.478775213276;52238.21642675439;52326.215106772666;394167;395076;395928;396323;398244;35232.29535409329;42792;42889.57110428856;47128.29307560458;47376.28935566038;50189.49810501848;50221.24668129908;50666.24000640067;50843;51193.23210151925;40704.3894341591;41351.37972930348;41796.58203417927;42269.36595951125;42376.5762342385;41168.1766364677;41515.7924210377;41572.58427415687;42150.78924605357;42419;41126.1774764509;41723;42664.78667606642;42771;42962.78518607387;36022.63977360193;36946.815265924575;37016.62983370132;37860.43209351917;38014.80992595019;28453.43093138167;28502.42995140127;28571.571426428203;28800.567991479726;28837 05:39:47 INFO - PROCESS | 15321 | |2;jquery.html;386.3585704732892;391.4050643022606;391.6377350950371;394.6467911219457;410.4151583992809;14421.173075966353;16350.83649163508;18294.725579116308;19607.705884411727;19611.411657650257;14198.635721814531;14993.700125997473;18664.16011279492;19121.808781912176;19158.90420547899;5456.345238571367;5456.563474922016;5603.719814009303;5644.181593668936;5763.0779075347955;3548.538689970313;5419.295491586088;5753.482186603205;5772.45161709639;5788.131780232978;5683.3464151622475;5768.682722450264;5784.913226301609;5787.50806181475;5794.565407594426;5718.799842005531;5762.769489220426;6071.180390647272;6397.712102955378;6412.839679008062;5553.222548843165;5651.378348381716;5654.236678048452;5667.064934285838;5682.573806964494;13103.934480327633;15413.691726165525;21166.682499762515;22292;22485.639007904098;2109.746830380349;2274.9658755118685;2372.952540949171;2411.915582954588;2863.599096126544;9892.406455612687;9902.653407130789;9926.90073099267;10209.540570674337;10277.640282590148;1785.9017754023523;1823.0975667044765;1825.9360922367787;1860.367475058473;1875.9155837987323;77887;80084;81036.18963810404;81936.59031704803;82438.58780706058;9988;10174.287799853939;10934.726631834268;10939.945300273448;11206.935341142578;13362.665933351744;13700.725985480234;15418.614534636723;15432.228388580526;15584.220788960507;8108.8378232435025;8114.756557303291;8174.427790054758;8174.9182508175345;8303.95848020768;7876.527408355517;7903.960480197562;7933.928919595896;8043.7989050273045;8121.390895682847;4554.453465584151;4640.071985602825;4685.789139488731;4699.389079419722;4709.552592503706;1878.2956391353243;1918.5491409518752;1952.3654812186096;1964.0114110160034;1970.9113089910988;871.1593312453513;983.1348413396165;1010.4493051287067;1033.7363972187045;1120.456578559398;18319;18691.81308186928;18734.156962936428;18737.812621873607;19104.14031368592;999.160705007797;1023.4115383654429;1028.7016765138176;1063.2185343772321;1083.247143235444;10490.947545262377;10565.524551395205;10694.091002264895;10723.249372544004;10779;504798;509442;509482;519195;520864;90551;92295.53852230696;93953.5302323484;95734;96465.5176724112;995.9352642078242;1024.3956065920993;1024.4775164666073;1063.4044934836515;1064.9680509584725;16706.916465417595;16740.58148546296;16920.238589263266;16923.66152676915;17280.22238999273;42210;42334.36498452464;43198.568014319455;44233.33649995317;44377;61384;61605.075923862074;62218.68890655518;63473.68263158655;64107.358926412;7555.357794587521;7864.292213700565;8382.58087095655;8385.454945428772;8680.131986801269;9097.77255568616;10773.784524309627;12914.22514649124;13529.391177397238;13682.384292707051;11586.13104017219;11821.172517923662;11851.170418070653;12034.75930481403;12141.271523708605;11630.592929247436;11676.299422034705;11681.941590292334;11792.351420671945;12024.819627705767;11898.524059037542;12007.39963001829;12077.939610301892;12110.273383597012;12162.574309899112;7808.375329973702;7821.608919553886;7823.765287041398;7858.292753652198;7964.681412743425;11195.60815371458;11885.346305953255;11921.165518413627;11979.700507487034;12162.574309899112 05:39:47 INFO - PROCESS | 15321 | |3;mootools.html;1314.796206587978;1523.3145084711882;1544.4478299309194;1673.3724853180058;1836.3572749537655;8156.469829461088;8637.827243455135;8642.135786421355;8685.869711954325;8709.172628600272;8441.451305665143;8640.870386944202;8652.30781537477;8669.869951950726;8672.52301123438;2059.5160137367707;2279.931602051941;2362;2380.3573035280465;2412.601920683085;2379;2394.568977584034;2395.796357309622;2401.1595941420537;2403.363108776167;2332.265336419031;2402.519496100787;2403.495265994143;2406.590879550472;2411.4815314707334;2068.9068991895324;2146.216630929715;2269.943251418711;2299.988500057506;2350.612148995414;2378.3935096550267;2396.364963284731;2398.9924231822674;2399.1003373734848;2399.844010139353;8532.57337133141;8589.055203927563;8624.18070283322;8625.913740862574;8626.525541095238;4987.576056035241;5014.749262536859;5217.452167522431;5220.660657057317;5233.005728911495;3259.1200375898375;3389.5932488101585;3446.5691788526433;3452.723782097426;3466.046837119787;1114.3035602748282;1153.371412580146;1164.3246916788241;1173.1904985559936;1181.0905602685884;11837.230580012272;11859.881401185963;11981.520739170423;12017.038636909114;12019.21875078117;4546.704464209815;4658.394408726912;4745.810167593258;4757.286407038971;4760.285957106462;10107.595696172071;10114.241431892637;10127.189824813997;10147.188224941987;10157.593696252216;5202.063628546898;5254.737263136904;5258.053550360972;5260.71066091361;5262.2632831403635;4396.296592545242;4745.5966242869745;4855.150348688965;4904.4605093439695;4972.875678108004;4035.5762644922447;4070.1352099311716;4131;4145.440365550612;4165.396017577435;1283.6726634708277;1302.8957683385306;1305.700827676468;1317.2425855133145;1318.4330737782655;968.2592816495387;968.9370190937567;975.1564896364594;983.7343917142474;990.5641517732319;5611.494965453129;5632.97183514088;5751.769929202785;5808.714568687196;5848.210491583582;460.2980454806447;463.9211334073216;470.4920729063344;472.79906039932894;484.46708620517853;3873.7482063666334;3927.6465118139504;3931.862384816575;3943.8028098594955;3963.6829053675638;10530.947345263225;10662.680119596425;10969.451527423596;10981.17641176915;10986.725331866608;10569.312994655324;10760.085392741705;10824.621138260123;10831.187660925305;10884.782304353868;8195.918040819515;8213.301869341172;8227.012758469022;8279.50322980623;8280.751577452686;5551.25058117149;5552.167174923794;5616;5654.671152279129;5705;9609.663661771805;9991.300608957303;10019.248556358156;10203.94898025505;10311.22665800053;10171.64399246023;10290.279680422598;10371;10422.895771042193;10568.10171135462;7074.04500392461;7578.43161762881;7826.843463130592;7837.49056311338;7978.0825205102155;8639.568021599021;8689.782755431164;8737.825243494968;8754.51850148248;8759.824803504021;7533.510321829063;7851.8037049071945;7868.803279917819;7869.213078692085;7899.131095579596;7549.849003019799;7581.090269167735;7601.049868766404;7660.119086305146;7814.53112813233;6810.148731408574;6861.1080559526945;6901.344372284625;6903.723851045902;6907.102076729993;5027.446980832033;5127.743612819419;5197.66215196011;5266.315379000705;5297.470252974672;5327.920081198863;5337.759800808895;5380.811671591476;5423.810166644149;5479.6164268500825 05:39:47 INFO - PROCESS | 15321 | |4;prototype.html;315.5597940872483;323.9951400728989;330.8974217992422;331.14894720568134;331.21336825040527;5162.896742065156;5265.921011184831;5274.393444753854;5283.260343551896;5308.362996440423;4979.67632103913;5047.747612619372;5200.765965531551;5215.530602245797;5248.6063545234065;4044.352903535435;4088.8364465421346;4099.282625540533;4104.8973775655695;4129.9174016519655;4075.3071977763702;4089.427480152781;4121.299379105544;4138.379243113527;4149.813258403379;3819.694424446038;3982.6614737747327;4072.226277007374;4072.9185416291657;4086.549275007374;4036.6568841648495;4044.898877528056;4061.2689715851134;4068.4914385701786;4070.5522392536795;3633.2370202257293;3633.582138054131;3641.0715267606593;3642.9817850910576;3650.8539658413633;4802.543758342987;5053.242013697938;5055.620828437882;5075.137226671474;5082.440931497532;4603;4613.261878099488;4617.430073774933;4623.606993405565;4635.165670179366;5393.139366918407;5440.483154100354;5444.700541470217;5448.945510544883;5469.261649677323;3704.240630670706;3909.394043923168;3914.393269043303;3920.4315374270573;3925.8037098145264;5643.407442218549;5678.403767604384;5696.2594862668;5696.401877802854;5702.887936852316;4004.5795191505053;4019.2765302245875;4030.1133750574827;4036.8183431745642;4048.959510404917;3884.261990221849;4017.879463616096;4051.959480405158;4057.634812866797;4062.5734297898885;4580.770961451914;4622.329762184464;4627.745473998895;4627.95372046282;4640.69835460694;5410.83767486976;5412.296401467784;5435.130379139318;5470.863228419242;5471.534919531884;1276.6170148955275;1316.394458549059;1333.9666508337175;1377.0704774277324;1393.9442422303198;873.4497266722052;877.8814859993947;885.8051228729669;890.701614958996;900.657750054988;4688.991866748597;4717.452575609202;4725.9527404726205;4731.976340118277;4788.970371370103;4904.852854414374;4924.679895806761;4956.603471722254;4970.701757894538;4980.726060066731;4498.752568608693;4719.834805781781;4721;4761.333413322138;4806.831760888352;2651.403434227322;2654.7257316487808;2665.813393062467;2666.6133410655348;2674.6790385153517;5105.974470127626;5118.436971933084;5120.795168193231;5122.564582010496;5157.406898206679;4758.7865094401395;4918.852434426973;5022.347094877716;5057.229969510716;5064.240363945438;5076.263941728429;5095;5115.514026167508;5127.538521533005;5151.97424012885;5006.549410553068;5024.598032157492;5029.371328583927;5035.320231768665;5048.334049763643;4615.976920115378;4870.245112007645;4919.631027672867;4977.328060711902;4991.650584459053;5066.594672426123;5126.564242039469;5173.534381905646;5210.400803907599;5237.895242095213;3642.2533380657433;3644.726645501545;3658.6341365864264;3669.7155995402463;3713.7400381974085;4809.9986756070375;4922.827701030446;4961.578265847299;5028.64799464034;5045;4834.685745426536;4846.466888642176;4850.253908592974;4852.272159176011;4888.413390393175;4709.670323077352;4714.245720684674;4822.276658501253;4842.394700662418;4914.886598762567;4701.506341834195;4742.573168414721;4750.928736068892;4766.80623981926;4975.651704380659;5478.643888147258;5523.563873393027;5564.8330550083565;5589.217509548585;5620.522255608155;5443.292371991616;5443.863903402446;5478.808241711521;5489.286392769074;5504.422035686355 05:39:47 INFO - PROCESS | 15321 | |5;yui.html;722.8084557592238;747.8803391457365;759.2255898983036;814.4828034198282;831.2311112221201;15378.84621153788;16328.510144695678;16334.673306533863;16345.346186152554;16349.427770028036;14705.191214483199;14748;14754.483593074245;14780.408783648669;14793.408263669467;666.1306994372342;776.8290975985274;791.9485233459822;800.9118996910364;812.8333691593209;797.8962734844491;801.310872649521;804.4288555125868;804.8108694456827;805.3235282362814;848.8302339532119;849.6346570974509;849.9065102838683;850.0776657326808;850.9191626795445;696.52984235641;817.1746535998655;842.1157784326464;843.5191940593865;848.1645579104577;618.7803329817895;619.8078595635322;619.845038740315;620.1503939602728;620.6090163197202;15200.771988420183;15241.771373429407;15243.39026438941;15299;15327.080375177526;14317.85682143186;14499.202543860083;14563.271836408243;14635.41458341665;14749.557513274618;12909.289989050598;12944.352782360938;13072.346382680827;13175.143615665047;13643.795343069862;4404.757738324391;4406.272964960777;4440.689151759379;4480.686351955364;4588.4723256825555;70843.29156708419;73708.26291737122;74424;74602;74770;11159.497822598003;11217.55129794799;11321.603743868925;11463.942680286546;11564.595239166589;21650.24224152147;21663.783362166178;21665.67501487479;21694;21714.782852171593;8081.191880811872;8181.181881811771;8193.754187374388;8329.08380078191;8401.789955251046;4440.555944405533;4451.6661250405705;4517.164324599959;4565.5206203348835;4647.86056418308;3244.6917542833394;3347.146477648184;3353.3628610563915;3354.4129777288877;3356.1274068741814;588.1236956934223;588.6262223488116;594.5778497266903;604.6764980735286;610.5848023344168;587.9706014699248;657.5495785387026;667.9469810880672;678.1613189890071;710.8542748736496;8881.156290152425;8964.596593153325;8978.595963181673;8987.46075235475;8993.325500587482;582.944620261083;587.6562211106551;623.5603899251017;664.3854434647932;719.9964000179965;4176.227397931392;4273.18809426208;4289.485261768607;4329.328954012133;4348.239058164809;68560.6571967137;69904.65047674831;106213;116805;116950.41524792321;96259;96793;98761;98821;98876.50561747146;74716.62641686757;76740.23259767443;87885.56057219673;88291;89772;10208.825985011521;10243.033212888939;10334.276600638184;10529.210309226686;10568.577256909637;37530.62469375271;39871;46537.767311163225;47464;53265.20102198393;74494;76164.61917690375;76568.61715691385;78078.6096069516;78884.21115788768;12363.072769542141;13084.177055068065;13098.738025239632;13222.867771322164;13384.109364783813;14274.785878212042;14528.782068268772;14623.85376146225;14753.92623036878;15038.097714137186;14419.495317663832;14654.56036318912;14654.706905861609;14685.55943321702;14686.192259425834;13870.722585548434;14411;14576.562703118923;14626.853731462976;14659.780103298246;13816.654583635087;13840.653983650489;14230.715385692436;14421.42314307416;14916.328765205375;10896.237263391486;11232.7753444929;11547.769044618892;11624.82562761576;11775.705607359885;11732.413379330828;11871.584494542649;12076;12119.394030298627;12178.6955326114 05:39:47 INFO - PROCESS | 15321 | __end_tp_report 05:39:47 INFO - PROCESS | 15321 | __start_cc_report 05:39:47 INFO - PROCESS | 15321 | _x_x_mozilla_cycle_collect,890 05:39:47 INFO - PROCESS | 15321 | __end_cc_report 05:39:47 INFO - PROCESS | 15321 | __startTimestamp1465216787762__endTimestamp 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | ------- Summary: start ------- 05:39:47 INFO - PROCESS | 15321 | Number of tests: 6 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#0] dojo.html Cycles:165 Average:5357.48 Median:5560.89 stddev:617.03 (11.1%) stddev-sans-first:593.17 05:39:47 INFO - PROCESS | 15321 | Values: 3108.9 3121.1 3132.6 3143.7 3167.6 5294.8 5318.4 5337.3 5376.8 5418.9 5383.7 5415.0 5420.1 5420.6 5457.6 4822.5 4893.3 4921.1 4921.3 4983.6 4911.5 4939.5 4956.3 4959.8 4975.6 4773.2 4816.0 4864.0 4878.8 4885.1 4874.1 4895.4 4924.2 4933.7 4983.6 4695.1 4899.5 4904.6 4919.0 4946.5 5173.1 5237.7 5247.7 5289.7 5306.5 5791.6 5828.6 5846.3 5851.3 5858.3 5609.3 5708.6 5830.2 5833.2 5835.2 5364.6 5479.9 5485.6 5486.5 5492.2 5943.0 5969.8 5974.1 5978.9 5982.1 5477.3 5632.0 5646.1 5729.3 5744.8 5782.9 5835.6 5842.2 5853.6 5855.3 5744.8 5762.9 5763.8 5792.2 5802.8 5535.4 5758.2 5775.4 5808.9 5822.5 4360.5 4363.1 4363.2 4371.4 4397.9 3928.1 3957.8 3973.4 4008.5 4030.5 5309.0 5355.8 5461.6 5488.9 5532.1 5842.8 5857.8 5858.4 5858.5 5895.3 5558.4 5560.9 5564.6 5565.3 5572.0 4692.1 4768.6 4788.5 4825.4 4825.8 5959.2 5982.5 5997.1 6002.2 6002.5 5677.1 5765.0 5777.0 5780.5 5785.0 5450.3 5925.9 5959.8 6004.7 6017.0 5691.7 5691.7 5696.1 5697.9 5713.9 5513.9 5709.2 5754.9 5755.5 5764.7 5630.2 5667.0 5674.9 5675.9 5724.1 5620.1 5661.3 5668.3 5671.4 5678.3 5465.5 5482.6 5511.5 5590.7 5591.2 5676.5 5689.2 5703.2 5717.8 5718.0 5549.5 5558.1 5560.1 5560.7 5563.0 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#1] ext.html Cycles:180 Average:60712.17 Median:23519.48 stddev:117135.62 (498.0%) stddev-sans-first:117377.26 05:39:47 INFO - PROCESS | 15321 | Values: 599.2 614.5 629.4 634.0 648.1 33973.3 34728.8 43260.8 44458.4 44515.8 45961.5 46436.0 46515.0 46563.8 46573.1 8676.8 8800.9 8853.0 8881.1 8882.5 8642.9 8715.4 8741.6 8747.8 8775.0 8813.3 8834.9 8857.4 8859.1 8859.8 8719.8 8775.3 8824.9 8830.4 8835.2 8729.6 8804.2 8818.3 8819.7 8827.8 42539.8 42962.4 42977.4 43060.4 43093.0 3471.4 3722.0 3722.7 4107.8 4268.0 31950.2 32462.2 32875.0 32891.0 34248.3 4382.3 4434.7 4558.2 4592.9 4597.8 357030.0 358675.0 358724.0 360278.0 360627.0 61698.7 61976.0 62458.4 62504.4 62609.4 65414.7 65507.0 65710.0 65760.3 65839.3 16815.0 17102.3 17107.7 17117.5 17123.6 13141.6 13178.0 13191.0 13195.3 13199.9 16778.9 18666.9 18805.3 18831.8 19009.5 5599.6 6298.8 6632.1 6673.2 6724.3 934.3 1092.4 1110.4 1132.4 1150.4 32366.7 33043.0 33053.2 33194.8 33494.3 1104.7 1119.6 1136.1 1149.5 1276.1 16849.2 17296.2 17458.2 17485.5 17518.4 543585.0 548157.0 549312.0 550965.0 553211.0 57977.0 58489.0 58550.1 58629.7 58654.1 1255.9 1337.2 1398.1 1413.5 1417.2 32424.2 33597.5 33601.0 33712.7 34375.1 51660.5 51986.2 52122.5 52238.2 52326.2 394167.0 395076.0 395928.0 396323.0 398244.0 35232.3 42792.0 42889.6 47128.3 47376.3 50189.5 50221.2 50666.2 50843.0 51193.2 40704.4 41351.4 41796.6 42269.4 42376.6 41168.2 41515.8 41572.6 42150.8 42419.0 41126.2 41723.0 42664.8 42771.0 42962.8 36022.6 36946.8 37016.6 37860.4 38014.8 28453.4 28502.4 28571.6 28800.6 28837.0 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#2] jquery.html Cycles:180 Average:29523.51 Median:3206.07 stddev:84566.31 (2637.7%) stddev-sans-first:84775.24 05:39:47 INFO - PROCESS | 15321 | Values: 386.4 391.4 391.6 394.6 410.4 14421.2 16350.8 18294.7 19607.7 19611.4 14198.6 14993.7 18664.2 19121.8 19158.9 5456.3 5456.6 5603.7 5644.2 5763.1 3548.5 5419.3 5753.5 5772.5 5788.1 5683.3 5768.7 5784.9 5787.5 5794.6 5718.8 5762.8 6071.2 6397.7 6412.8 5553.2 5651.4 5654.2 5667.1 5682.6 13103.9 15413.7 21166.7 22292.0 22485.6 2109.7 2275.0 2373.0 2411.9 2863.6 9892.4 9902.7 9926.9 10209.5 10277.6 1785.9 1823.1 1825.9 1860.4 1875.9 77887.0 80084.0 81036.2 81936.6 82438.6 9988.0 10174.3 10934.7 10939.9 11206.9 13362.7 13700.7 15418.6 15432.2 15584.2 8108.8 8114.8 8174.4 8174.9 8304.0 7876.5 7904.0 7933.9 8043.8 8121.4 4554.5 4640.1 4685.8 4699.4 4709.6 1878.3 1918.5 1952.4 1964.0 1970.9 871.2 983.1 1010.4 1033.7 1120.5 18319.0 18691.8 18734.2 18737.8 19104.1 999.2 1023.4 1028.7 1063.2 1083.2 10490.9 10565.5 10694.1 10723.2 10779.0 504798.0 509442.0 509482.0 519195.0 520864.0 90551.0 92295.5 93953.5 95734.0 96465.5 995.9 1024.4 1024.5 1063.4 1065.0 16706.9 16740.6 16920.2 16923.7 17280.2 42210.0 42334.4 43198.6 44233.3 44377.0 61384.0 61605.1 62218.7 63473.7 64107.4 7555.4 7864.3 8382.6 8385.5 8680.1 9097.8 10773.8 12914.2 13529.4 13682.4 11586.1 11821.2 11851.2 12034.8 12141.3 11630.6 11676.3 11681.9 11792.4 12024.8 11898.5 12007.4 12077.9 12110.3 12162.6 7808.4 7821.6 7823.8 7858.3 7964.7 11195.6 11885.3 11921.2 11979.7 12162.6 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#3] mootools.html Cycles:180 Average:5755.30 Median:4745.70 stddev:3267.78 (68.9%) stddev-sans-first:3259.90 05:39:47 INFO - PROCESS | 15321 | Values: 1314.8 1523.3 1544.4 1673.4 1836.4 8156.5 8637.8 8642.1 8685.9 8709.2 8441.5 8640.9 8652.3 8669.9 8672.5 2059.5 2279.9 2362.0 2380.4 2412.6 2379.0 2394.6 2395.8 2401.2 2403.4 2332.3 2402.5 2403.5 2406.6 2411.5 2068.9 2146.2 2269.9 2300.0 2350.6 2378.4 2396.4 2399.0 2399.1 2399.8 8532.6 8589.1 8624.2 8625.9 8626.5 4987.6 5014.7 5217.5 5220.7 5233.0 3259.1 3389.6 3446.6 3452.7 3466.0 1114.3 1153.4 1164.3 1173.2 1181.1 11837.2 11859.9 11981.5 12017.0 12019.2 4546.7 4658.4 4745.8 4757.3 4760.3 10107.6 10114.2 10127.2 10147.2 10157.6 5202.1 5254.7 5258.1 5260.7 5262.3 4396.3 4745.6 4855.2 4904.5 4972.9 4035.6 4070.1 4131.0 4145.4 4165.4 1283.7 1302.9 1305.7 1317.2 1318.4 968.3 968.9 975.2 983.7 990.6 5611.5 5633.0 5751.8 5808.7 5848.2 460.3 463.9 470.5 472.8 484.5 3873.7 3927.6 3931.9 3943.8 3963.7 10530.9 10662.7 10969.5 10981.2 10986.7 10569.3 10760.1 10824.6 10831.2 10884.8 8195.9 8213.3 8227.0 8279.5 8280.8 5551.3 5552.2 5616.0 5654.7 5705.0 9609.7 9991.3 10019.2 10203.9 10311.2 10171.6 10290.3 10371.0 10422.9 10568.1 7074.0 7578.4 7826.8 7837.5 7978.1 8639.6 8689.8 8737.8 8754.5 8759.8 7533.5 7851.8 7868.8 7869.2 7899.1 7549.8 7581.1 7601.0 7660.1 7814.5 6810.1 6861.1 6901.3 6903.7 6907.1 5027.4 5127.7 5197.7 5266.3 5297.5 5327.9 5337.8 5380.8 5423.8 5479.6 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#4] prototype.html Cycles:180 Average:4360.97 Median:4828.48 stddev:1244.63 (25.8%) stddev-sans-first:1210.52 05:39:47 INFO - PROCESS | 15321 | Values: 315.6 324.0 330.9 331.1 331.2 5162.9 5265.9 5274.4 5283.3 5308.4 4979.7 5047.7 5200.8 5215.5 5248.6 4044.4 4088.8 4099.3 4104.9 4129.9 4075.3 4089.4 4121.3 4138.4 4149.8 3819.7 3982.7 4072.2 4072.9 4086.5 4036.7 4044.9 4061.3 4068.5 4070.6 3633.2 3633.6 3641.1 3643.0 3650.9 4802.5 5053.2 5055.6 5075.1 5082.4 4603.0 4613.3 4617.4 4623.6 4635.2 5393.1 5440.5 5444.7 5448.9 5469.3 3704.2 3909.4 3914.4 3920.4 3925.8 5643.4 5678.4 5696.3 5696.4 5702.9 4004.6 4019.3 4030.1 4036.8 4049.0 3884.3 4017.9 4052.0 4057.6 4062.6 4580.8 4622.3 4627.7 4628.0 4640.7 5410.8 5412.3 5435.1 5470.9 5471.5 1276.6 1316.4 1334.0 1377.1 1393.9 873.4 877.9 885.8 890.7 900.7 4689.0 4717.5 4726.0 4732.0 4789.0 4904.9 4924.7 4956.6 4970.7 4980.7 4498.8 4719.8 4721.0 4761.3 4806.8 2651.4 2654.7 2665.8 2666.6 2674.7 5106.0 5118.4 5120.8 5122.6 5157.4 4758.8 4918.9 5022.3 5057.2 5064.2 5076.3 5095.0 5115.5 5127.5 5152.0 5006.5 5024.6 5029.4 5035.3 5048.3 4616.0 4870.2 4919.6 4977.3 4991.7 5066.6 5126.6 5173.5 5210.4 5237.9 3642.3 3644.7 3658.6 3669.7 3713.7 4810.0 4922.8 4961.6 5028.6 5045.0 4834.7 4846.5 4850.3 4852.3 4888.4 4709.7 4714.2 4822.3 4842.4 4914.9 4701.5 4742.6 4750.9 4766.8 4975.7 5478.6 5523.6 5564.8 5589.2 5620.5 5443.3 5443.9 5478.8 5489.3 5504.4 05:39:47 INFO - PROCESS | 15321 | 05:39:47 INFO - PROCESS | 15321 | [#5] yui.html Cycles:180 Average:20124.47 Median:4405.52 stddev:28140.77 (638.8%) stddev-sans-first:28182.01 05:39:47 INFO - PROCESS | 15321 | Values: 722.8 747.9 759.2 814.5 831.2 15378.8 16328.5 16334.7 16345.3 16349.4 14705.2 14748.0 14754.5 14780.4 14793.4 666.1 776.8 791.9 800.9 812.8 797.9 801.3 804.4 804.8 805.3 848.8 849.6 849.9 850.1 850.9 696.5 817.2 842.1 843.5 848.2 618.8 619.8 619.8 620.2 620.6 15200.8 15241.8 15243.4 15299.0 15327.1 14317.9 14499.2 14563.3 14635.4 14749.6 12909.3 12944.4 13072.3 13175.1 13643.8 4404.8 4406.3 4440.7 4480.7 4588.5 70843.3 73708.3 74424.0 74602.0 74770.0 11159.5 11217.6 11321.6 11463.9 11564.6 21650.2 21663.8 21665.7 21694.0 21714.8 8081.2 8181.2 8193.8 8329.1 8401.8 4440.6 4451.7 4517.2 4565.5 4647.9 3244.7 3347.1 3353.4 3354.4 3356.1 588.1 588.6 594.6 604.7 610.6 588.0 657.5 667.9 678.2 710.9 8881.2 8964.6 8978.6 8987.5 8993.3 582.9 587.7 623.6 664.4 720.0 4176.2 4273.2 4289.5 4329.3 4348.2 68560.7 69904.7 106213.0 116805.0 116950.4 96259.0 96793.0 98761.0 98821.0 98876.5 74716.6 76740.2 87885.6 88291.0 89772.0 10208.8 10243.0 10334.3 10529.2 10568.6 37530.6 39871.0 46537.8 47464.0 53265.2 74494.0 76164.6 76568.6 78078.6 78884.2 12363.1 13084.2 13098.7 13222.9 13384.1 14274.8 14528.8 14623.9 14753.9 15038.1 14419.5 14654.6 14654.7 14685.6 14686.2 13870.7 14411.0 14576.6 14626.9 14659.8 13816.7 13840.7 14230.7 14421.4 14916.3 10896.2 11232.8 11547.8 11624.8 11775.7 11732.4 11871.6 12076.0 12119.4 12178.7 05:39:47 INFO - PROCESS | 15321 | -------- Summary: end -------- 05:39:47 INFO - PROCESS | 15321 | 05:39:48 INFO - TEST-INFO | 15321: exit 0 05:39:48 INFO - TEST-OK | dromaeo_css | took 1112804ms 05:39:48 INFO - TEST-START | kraken 05:39:48 INFO - operating with platform_type : linux_ 05:39:48 INFO - Initialising browser for kraken test... 05:39:48 INFO - TEST-INFO | started process 15498 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhvvPN/profile http://localhost:54217/getInfo.html) 05:39:52 INFO - PROCESS | 15498 | __metrics Screen width/height:1600/1200 05:39:52 INFO - PROCESS | 15498 | colorDepth:24 05:39:52 INFO - PROCESS | 15498 | Browser inner width/height: 1024/697 05:39:52 INFO - PROCESS | 15498 | __metrics 05:39:53 ERROR - PROCESS | 15498 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:39:54 INFO - TEST-INFO | 15498: exit 0 05:39:54 INFO - Browser initialized. 05:39:54 INFO - Running cycle 1/1 for kraken test... 05:39:54 INFO - TEST-INFO | started process 15581 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphhvvPN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:40:06 INFO - PROCESS | 15581 | RSS: Main: 156774400 05:40:06 INFO - PROCESS | 15581 | 05:40:08 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54217/tests/kraken/driver.html?testName=audio-beat-detection) 05:40:09 INFO - PROCESS | 15581 | RSS: Main: 214732800 05:40:09 INFO - PROCESS | 15581 | 05:40:12 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54217/tests/kraken/driver.html?testName=audio-dft) 05:40:12 INFO - PROCESS | 15581 | RSS: Main: 201850880 05:40:12 INFO - PROCESS | 15581 | 05:40:15 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54217/tests/kraken/driver.html?testName=audio-fft) 05:40:16 INFO - PROCESS | 15581 | RSS: Main: 268861440 05:40:16 INFO - PROCESS | 15581 | 05:40:18 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54217/tests/kraken/driver.html?testName=audio-oscillator) 05:40:19 INFO - PROCESS | 15581 | RSS: Main: 179224576 05:40:19 INFO - PROCESS | 15581 | 05:40:21 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54217/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:40:21 INFO - PROCESS | 15581 | RSS: Main: 184373248 05:40:21 INFO - PROCESS | 15581 | 05:40:25 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54217/tests/kraken/driver.html?testName=imaging-darkroom) 05:40:25 INFO - PROCESS | 15581 | RSS: Main: 218415104 05:40:25 INFO - PROCESS | 15581 | 05:40:28 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54217/tests/kraken/driver.html?testName=imaging-desaturate) 05:40:29 INFO - PROCESS | 15581 | RSS: Main: 220618752 05:40:29 INFO - PROCESS | 15581 | 05:40:32 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54217/tests/kraken/driver.html?testName=json-parse-financial) 05:40:33 INFO - PROCESS | 15581 | RSS: Main: 220475392 05:40:33 INFO - PROCESS | 15581 | 05:40:34 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54217/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:40:35 INFO - PROCESS | 15581 | RSS: Main: 205864960 05:40:35 INFO - PROCESS | 15581 | 05:40:36 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:40:37 INFO - PROCESS | 15581 | RSS: Main: 211607552 05:40:37 INFO - PROCESS | 15581 | 05:40:39 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:40:40 INFO - PROCESS | 15581 | RSS: Main: 217350144 05:40:40 INFO - PROCESS | 15581 | 05:40:42 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:40:43 INFO - PROCESS | 15581 | RSS: Main: 222171136 05:40:43 INFO - PROCESS | 15581 | 05:40:46 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:40:46 INFO - PROCESS | 15581 | RSS: Main: 222212096 05:40:46 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | Cycle 1(1): loaded http://localhost:54217/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54217/tests/kraken/driver.html?testName=ai-astar) 05:40:48 INFO - PROCESS | 15581 | RSS: Main: 264769536 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | __start_tp_report 05:40:48 INFO - PROCESS | 15581 | _x_x_mozilla_page_load 05:40:48 INFO - PROCESS | 15581 | _x_x_mozilla_page_load_details 05:40:48 INFO - PROCESS | 15581 | |i|pagename|runs| 05:40:48 INFO - PROCESS | 15581 | |0;ai-astar;112;106;110;110;109;110;110;112;113;111 05:40:48 INFO - PROCESS | 15581 | |1;audio-beat-detection;162;132;126;178;131;132;159;126;178;125 05:40:48 INFO - PROCESS | 15581 | |2;audio-dft;160;160;163;161;164;159;159;159;160;161 05:40:48 INFO - PROCESS | 15581 | |3;audio-fft;81;74;75;131;76;76;76;74;99;75 05:40:48 INFO - PROCESS | 15581 | |4;audio-oscillator;85;85;107;84;84;84;117;85;86;141 05:40:48 INFO - PROCESS | 15581 | |5;imaging-gaussian-blur;117;117;116;116;116;117;116;117;116;117 05:40:48 INFO - PROCESS | 15581 | |6;imaging-darkroom;146;146;146;145;146;145;146;146;146;145 05:40:48 INFO - PROCESS | 15581 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;96 05:40:48 INFO - PROCESS | 15581 | |8;json-parse-financial;54;53;53;53;53;54;57;54;53;54 05:40:48 INFO - PROCESS | 15581 | |9;json-stringify-tinderbox;61;62;62;62;61;62;62;62;61;61 05:40:48 INFO - PROCESS | 15581 | |10;stanford-crypto-aes;82;79;79;80;85;82;86;88;112;87 05:40:48 INFO - PROCESS | 15581 | |11;stanford-crypto-ccm;126;126;131;120;120;120;126;122;137;134 05:40:48 INFO - PROCESS | 15581 | |12;stanford-crypto-pbkdf2;182;162;162;163;160;163;159;162;159;160 05:40:48 INFO - PROCESS | 15581 | |13;stanford-crypto-sha256-iterative;64;62;65;63;63;69;63;63;66;65 05:40:48 INFO - PROCESS | 15581 | __end_tp_report 05:40:48 INFO - PROCESS | 15581 | __start_cc_report 05:40:48 INFO - PROCESS | 15581 | _x_x_mozilla_cycle_collect,1636 05:40:48 INFO - PROCESS | 15581 | __end_cc_report 05:40:48 INFO - PROCESS | 15581 | __startTimestamp1465216848684__endTimestamp 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | ------- Summary: start ------- 05:40:48 INFO - PROCESS | 15581 | Number of tests: 14 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#0] ai-astar Cycles:10 Average:110.30 Median:110.50 stddev:1.95 (1.8%) stddev-sans-first:1.96 05:40:48 INFO - PROCESS | 15581 | Values: 112.0 106.0 110.0 110.0 109.0 110.0 110.0 112.0 113.0 111.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#1] audio-beat-detection Cycles:10 Average:144.90 Median:145.50 stddev:21.91 (15.1%) stddev-sans-first:22.34 05:40:48 INFO - PROCESS | 15581 | Values: 162.0 132.0 126.0 178.0 131.0 132.0 159.0 126.0 178.0 125.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:1.71 (1.1%) stddev-sans-first:1.80 05:40:48 INFO - PROCESS | 15581 | Values: 160.0 160.0 163.0 161.0 164.0 159.0 159.0 159.0 160.0 161.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#3] audio-fft Cycles:10 Average:83.70 Median:76.00 stddev:18.25 (24.0%) stddev-sans-first:19.33 05:40:48 INFO - PROCESS | 15581 | Values: 81.0 74.0 75.0 131.0 76.0 76.0 76.0 74.0 99.0 75.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.50 stddev:19.67 (23.3%) stddev-sans-first:20.47 05:40:48 INFO - PROCESS | 15581 | Values: 85.0 85.0 107.0 84.0 84.0 84.0 117.0 85.0 86.0 141.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#5] imaging-gaussian-blur Cycles:10 Average:116.50 Median:117.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:40:48 INFO - PROCESS | 15581 | Values: 117.0 117.0 116.0 116.0 116.0 117.0 116.0 117.0 116.0 117.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:40:48 INFO - PROCESS | 15581 | Values: 146.0 146.0 146.0 145.0 146.0 145.0 146.0 146.0 146.0 145.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 05:40:48 INFO - PROCESS | 15581 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.23 (2.3%) stddev-sans-first:1.30 05:40:48 INFO - PROCESS | 15581 | Values: 54.0 53.0 53.0 53.0 53.0 54.0 57.0 54.0 53.0 54.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#9] json-stringify-tinderbox Cycles:10 Average:61.60 Median:62.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 05:40:48 INFO - PROCESS | 15581 | Values: 61.0 62.0 62.0 62.0 61.0 62.0 62.0 62.0 61.0 61.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#10] stanford-crypto-aes Cycles:10 Average:86.00 Median:83.50 stddev:9.71 (11.6%) stddev-sans-first:10.19 05:40:48 INFO - PROCESS | 15581 | Values: 82.0 79.0 79.0 80.0 85.0 82.0 86.0 88.0 112.0 87.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:126.00 stddev:6.09 (4.8%) stddev-sans-first:6.46 05:40:48 INFO - PROCESS | 15581 | Values: 126.0 126.0 131.0 120.0 120.0 120.0 126.0 122.0 137.0 134.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.20 Median:162.00 stddev:6.78 (4.2%) stddev-sans-first:1.62 05:40:48 INFO - PROCESS | 15581 | Values: 182.0 162.0 162.0 163.0 160.0 163.0 159.0 162.0 159.0 160.0 05:40:48 INFO - PROCESS | 15581 | 05:40:48 INFO - PROCESS | 15581 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.30 Median:64.50 stddev:2.06 (3.2%) stddev-sans-first:2.18 05:40:48 INFO - PROCESS | 15581 | Values: 64.0 62.0 65.0 63.0 63.0 69.0 63.0 63.0 66.0 65.0 05:40:48 INFO - PROCESS | 15581 | -------- Summary: end -------- 05:40:48 INFO - PROCESS | 15581 | 05:40:49 INFO - TEST-INFO | 15581: exit 0 05:40:49 INFO - TEST-OK | kraken | took 61149ms 05:40:49 INFO - SUITE-END | took 1173s 05:40:49 INFO - Completed test suite (00:19:34) 05:40:49 INFO - javascript benchmark 05:40:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.9067327980156, 3121.0636808957315, 3132.6240851097864, 3143.7170654641077, 3167.5565420841085, 5294.814681486148, 5318.361796584415, 5337.252784610153, 5376.8118115865955, 5418.8916221675545, 5383.67697938123, 5414.972925135369, 5420.105682562373, 5420.620556561043, 5457.645253058548, 4822.493638167985, 4893.314935908976, 4921.114199444099, 4921.311016457699, 4983.6013118950395, 4911.508849115078, 4939.481354457784, 4956.2565615157655, 4959.776810043539, 4975.552200301972, 4773.164696178173, 4816.0, 4864.027194561084, 4878.756062196876, 4885.096257192431, 4874.098291816025, 4895.363602731658, 4924.187509061001, 4933.7286449245275, 4983.551480366785, 4695.131400690883, 4899.534544218293, 4904.6321525885705, 4919.0, 4946.480619534969, 5173.120569503193, 5237.659552129099, 5247.711375874325, 5289.656172348785, 5306.495882891119, 5791.623544469596, 5828.621139625953, 5846.327672317695, 5851.268591426072, 5858.297004359504, 5609.298837645294, 5708.600397972144, 5830.212921255618, 5833.212516310286, 5835.153902684087, 5364.570834333244, 5479.863003424906, 5485.61600687952, 5486.506214440719, 5492.231087647732, 5942.970285148546, 5969.820905372759, 5974.074018527135, 5978.910316345258, 5982.0727787193055, 5477.315335583052, 5632.0, 5646.096624540054, 5729.341125770589, 5744.798932037359, 5782.9012487627215, 5835.591508594358, 5842.211301474332, 5853.64878107315, 5855.326637436664, 5744.770209191669, 5762.855928601734, 5763.7982670606325, 5792.247007888947, 5802.767889284466, 5535.391106978229, 5758.193852860602, 5775.422457754275, 5808.88382232353, 5822.534197264209, 4360.520342762294, 4363.06194168249, 4363.170997510463, 4371.431713877176, 4397.868063958086, 3928.0769019280447, 3957.8021098945514, 3973.4238535412783, 4008.518977722692, 4030.536488303824, 5308.991291654574, 5355.758990845421, 5461.590380721462, 5488.91766623501, 5532.1425179097305, 5842.766289348463, 5857.824265272048, 5858.414158584107, 5858.502027327725, 5895.29256489224, 5558.44415558441, 5560.888782224414, 5564.582656300794, 5565.332160140728, 5572.024895643246, 4692.1084993851055, 4768.61851051915, 4788.521147885183, 4825.420949486084, 4825.758712064383, 5959.225300710967, 5982.521398288127, 5997.100434934795, 6002.159697642333, 6002.459778619946, 5677.063284558001, 5764.971175144097, 5777.0, 5780.479756821906, 5785.0, 5450.264214331173, 5925.911111333247, 5959.791407300723, 6004.729787159676, 6017.037274036134, 5691.658500489818, 5691.743871525874, 5696.088625820014, 5697.914531281951, 5713.885722285448, 5513.889722205453, 5709.22925405065, 5754.9424505754405, 5755.510781583444, 5764.682942438206, 5630.183623374506, 5666.951613951433, 5674.914876276776, 5675.858103547444, 5724.141378793214, 5620.1288800236025, 5661.2923384576925, 5668.319801623831, 5671.376148623565, 5678.3186017678145, 5465.508104270476, 5482.643628164156, 5511.476409741068, 5590.692511911884, 5591.161325800999, 5676.489115979416, 5689.175069614966, 5703.230063941481, 5717.799877004285, 5718.0, 5549.500544950974, 5558.110702287615, 5560.138178582326, 5560.749766260447, 5562.972185139049], "value": 5315.6922676744825, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [599.2030599302927, 614.5483069943591, 629.3643420145654, 634.0299342006729, 648.1444493268887, 33973.320533589314, 34728.826355868216, 43260.783696081475, 44458.44332453404, 44515.77742111285, 45961.54038459614, 46436.0, 46515.0, 46563.767181164134, 46573.06853862921, 8676.783080422976, 8800.911990880106, 8853.026167121612, 8881.067487913773, 8882.511461869595, 8642.913570864304, 8715.433496822718, 8741.606627701769, 8747.781305467382, 8774.956125219365, 8813.338999575026, 8834.911650883474, 8857.379983401132, 8859.11408859112, 8859.778505537348, 8719.782005449852, 8775.297976161924, 8824.911750882537, 8830.381873268874, 8835.20483156519, 8729.563521823884, 8804.207621314112, 8818.29453643707, 8819.691310804155, 8827.779305517413, 42539.7873010636, 42962.35556466624, 42977.35533966993, 43060.354094688606, 43093.0, 3471.409860323751, 3722.0, 3722.7394082414244, 4107.774072426016, 4267.957320426818, 31950.20124496883, 32462.18844528882, 32875.0, 32891.0, 34248.31503369919, 4382.298832186867, 4434.73391596502, 4558.156741002892, 4592.908141837178, 4597.839075632371, 357030.0, 358675.0, 358724.0, 360278.0, 360627.0, 61698.69150654308, 61976.0, 62458.37541624616, 62504.374956249856, 62609.373906261266, 65414.67292663506, 65507.0, 65710.0286991391, 65760.34239657638, 65839.34160658428, 16815.0, 17102.315907363565, 17107.65784684324, 17117.486475405756, 17123.57191070208, 13141.60575182727, 13178.0, 13191.0, 13195.274259915604, 13199.934000329937, 16778.875737503142, 18666.906665466857, 18805.341813036477, 18831.81168188328, 19009.524761881064, 5599.580031497654, 6298.811035668938, 6632.071509988606, 6673.1992160941, 6724.293949135368, 934.3226161033197, 1092.448313601626, 1110.4114819145866, 1132.4451019000794, 1150.442035612727, 32366.676333236835, 33043.0, 33053.17367065795, 33194.8340258302, 33494.3301133976, 1104.6630777612745, 1119.5913491575516, 1136.1478890831877, 1149.4540093455541, 1276.1003492537739, 16849.156254025467, 17296.22167002488, 17458.214380352914, 17485.47543573695, 17518.38685645996, 543585.0, 548157.0, 549312.0, 550965.0, 553211.0, 57977.0, 58489.0, 58550.12174817381, 58629.706851466326, 58654.12018819721, 1255.9183653062705, 1337.237774468563, 1398.0982266438293, 1413.4557397965384, 1417.2276109520337, 32424.189395264362, 33597.456419690476, 33601.0, 33712.66287337095, 34375.140621484665, 51660.48339516557, 51986.22020669769, 52122.478775213276, 52238.21642675439, 52326.215106772666, 394167.0, 395076.0, 395928.0, 396323.0, 398244.0, 35232.29535409329, 42792.0, 42889.57110428856, 47128.29307560458, 47376.28935566038, 50189.49810501848, 50221.24668129908, 50666.24000640067, 50843.0, 51193.23210151925, 40704.3894341591, 41351.37972930348, 41796.58203417927, 42269.36595951125, 42376.5762342385, 41168.1766364677, 41515.7924210377, 41572.58427415687, 42150.78924605357, 42419.0, 41126.1774764509, 41723.0, 42664.78667606642, 42771.0, 42962.78518607387, 36022.63977360193, 36946.815265924575, 37016.62983370132, 37860.43209351917, 38014.80992595019, 28453.43093138167, 28502.42995140127, 28571.571426428203, 28800.567991479726, 28837.0], "value": 20652.646153153317, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.3585704732892, 391.4050643022606, 391.6377350950371, 394.6467911219457, 410.4151583992809, 14421.173075966353, 16350.83649163508, 18294.725579116308, 19607.705884411727, 19611.411657650257, 14198.635721814531, 14993.700125997473, 18664.16011279492, 19121.808781912176, 19158.90420547899, 5456.345238571367, 5456.563474922016, 5603.719814009303, 5644.181593668936, 5763.0779075347955, 3548.538689970313, 5419.295491586088, 5753.482186603205, 5772.45161709639, 5788.131780232978, 5683.3464151622475, 5768.682722450264, 5784.913226301609, 5787.50806181475, 5794.565407594426, 5718.799842005531, 5762.769489220426, 6071.180390647272, 6397.712102955378, 6412.839679008062, 5553.222548843165, 5651.378348381716, 5654.236678048452, 5667.064934285838, 5682.573806964494, 13103.934480327633, 15413.691726165525, 21166.682499762515, 22292.0, 22485.639007904098, 2109.746830380349, 2274.9658755118685, 2372.952540949171, 2411.915582954588, 2863.599096126544, 9892.406455612687, 9902.653407130789, 9926.90073099267, 10209.540570674337, 10277.640282590148, 1785.9017754023523, 1823.0975667044765, 1825.9360922367787, 1860.367475058473, 1875.9155837987323, 77887.0, 80084.0, 81036.18963810404, 81936.59031704803, 82438.58780706058, 9988.0, 10174.287799853939, 10934.726631834268, 10939.945300273448, 11206.935341142578, 13362.665933351744, 13700.725985480234, 15418.614534636723, 15432.228388580526, 15584.220788960507, 8108.8378232435025, 8114.756557303291, 8174.427790054758, 8174.9182508175345, 8303.95848020768, 7876.527408355517, 7903.960480197562, 7933.928919595896, 8043.7989050273045, 8121.390895682847, 4554.453465584151, 4640.071985602825, 4685.789139488731, 4699.389079419722, 4709.552592503706, 1878.2956391353243, 1918.5491409518752, 1952.3654812186096, 1964.0114110160034, 1970.9113089910988, 871.1593312453513, 983.1348413396165, 1010.4493051287067, 1033.7363972187045, 1120.456578559398, 18319.0, 18691.81308186928, 18734.156962936428, 18737.812621873607, 19104.14031368592, 999.160705007797, 1023.4115383654429, 1028.7016765138176, 1063.2185343772321, 1083.247143235444, 10490.947545262377, 10565.524551395205, 10694.091002264895, 10723.249372544004, 10779.0, 504798.0, 509442.0, 509482.0, 519195.0, 520864.0, 90551.0, 92295.53852230696, 93953.5302323484, 95734.0, 96465.5176724112, 995.9352642078242, 1024.3956065920993, 1024.4775164666073, 1063.4044934836515, 1064.9680509584725, 16706.916465417595, 16740.58148546296, 16920.238589263266, 16923.66152676915, 17280.22238999273, 42210.0, 42334.36498452464, 43198.568014319455, 44233.33649995317, 44377.0, 61384.0, 61605.075923862074, 62218.68890655518, 63473.68263158655, 64107.358926412, 7555.357794587521, 7864.292213700565, 8382.58087095655, 8385.454945428772, 8680.131986801269, 9097.77255568616, 10773.784524309627, 12914.22514649124, 13529.391177397238, 13682.384292707051, 11586.13104017219, 11821.172517923662, 11851.170418070653, 12034.75930481403, 12141.271523708605, 11630.592929247436, 11676.299422034705, 11681.941590292334, 11792.351420671945, 12024.819627705767, 11898.524059037542, 12007.39963001829, 12077.939610301892, 12110.273383597012, 12162.574309899112, 7808.375329973702, 7821.608919553886, 7823.765287041398, 7858.292753652198, 7964.681412743425, 11195.60815371458, 11885.346305953255, 11921.165518413627, 11979.700507487034, 12162.574309899112], "value": 9085.838602670363, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1314.796206587978, 1523.3145084711882, 1544.4478299309194, 1673.3724853180058, 1836.3572749537655, 8156.469829461088, 8637.827243455135, 8642.135786421355, 8685.869711954325, 8709.172628600272, 8441.451305665143, 8640.870386944202, 8652.30781537477, 8669.869951950726, 8672.52301123438, 2059.5160137367707, 2279.931602051941, 2362.0, 2380.3573035280465, 2412.601920683085, 2379.0, 2394.568977584034, 2395.796357309622, 2401.1595941420537, 2403.363108776167, 2332.265336419031, 2402.519496100787, 2403.495265994143, 2406.590879550472, 2411.4815314707334, 2068.9068991895324, 2146.216630929715, 2269.943251418711, 2299.988500057506, 2350.612148995414, 2378.3935096550267, 2396.364963284731, 2398.9924231822674, 2399.1003373734848, 2399.844010139353, 8532.57337133141, 8589.055203927563, 8624.18070283322, 8625.913740862574, 8626.525541095238, 4987.576056035241, 5014.749262536859, 5217.452167522431, 5220.660657057317, 5233.005728911495, 3259.1200375898375, 3389.5932488101585, 3446.5691788526433, 3452.723782097426, 3466.046837119787, 1114.3035602748282, 1153.371412580146, 1164.3246916788241, 1173.1904985559936, 1181.0905602685884, 11837.230580012272, 11859.881401185963, 11981.520739170423, 12017.038636909114, 12019.21875078117, 4546.704464209815, 4658.394408726912, 4745.810167593258, 4757.286407038971, 4760.285957106462, 10107.595696172071, 10114.241431892637, 10127.189824813997, 10147.188224941987, 10157.593696252216, 5202.063628546898, 5254.737263136904, 5258.053550360972, 5260.71066091361, 5262.2632831403635, 4396.296592545242, 4745.5966242869745, 4855.150348688965, 4904.4605093439695, 4972.875678108004, 4035.5762644922447, 4070.1352099311716, 4131.0, 4145.440365550612, 4165.396017577435, 1283.6726634708277, 1302.8957683385306, 1305.700827676468, 1317.2425855133145, 1318.4330737782655, 968.2592816495387, 968.9370190937567, 975.1564896364594, 983.7343917142474, 990.5641517732319, 5611.494965453129, 5632.97183514088, 5751.769929202785, 5808.714568687196, 5848.210491583582, 460.2980454806447, 463.9211334073216, 470.4920729063344, 472.79906039932894, 484.46708620517853, 3873.7482063666334, 3927.6465118139504, 3931.862384816575, 3943.8028098594955, 3963.6829053675638, 10530.947345263225, 10662.680119596425, 10969.451527423596, 10981.17641176915, 10986.725331866608, 10569.312994655324, 10760.085392741705, 10824.621138260123, 10831.187660925305, 10884.782304353868, 8195.918040819515, 8213.301869341172, 8227.012758469022, 8279.50322980623, 8280.751577452686, 5551.25058117149, 5552.167174923794, 5616.0, 5654.671152279129, 5705.0, 9609.663661771805, 9991.300608957303, 10019.248556358156, 10203.94898025505, 10311.22665800053, 10171.64399246023, 10290.279680422598, 10371.0, 10422.895771042193, 10568.10171135462, 7074.04500392461, 7578.43161762881, 7826.843463130592, 7837.49056311338, 7978.0825205102155, 8639.568021599021, 8689.782755431164, 8737.825243494968, 8754.51850148248, 8759.824803504021, 7533.510321829063, 7851.8037049071945, 7868.803279917819, 7869.213078692085, 7899.131095579596, 7549.849003019799, 7581.090269167735, 7601.049868766404, 7660.119086305146, 7814.53112813233, 6810.148731408574, 6861.1080559526945, 6901.344372284625, 6903.723851045902, 6907.102076729993, 5027.446980832033, 5127.743612819419, 5197.66215196011, 5266.315379000705, 5297.470252974672, 5327.920081198863, 5337.759800808895, 5380.811671591476, 5423.810166644149, 5479.6164268500825], "value": 4548.917460879043, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.5597940872483, 323.9951400728989, 330.8974217992422, 331.14894720568134, 331.21336825040527, 5162.896742065156, 5265.921011184831, 5274.393444753854, 5283.260343551896, 5308.362996440423, 4979.67632103913, 5047.747612619372, 5200.765965531551, 5215.530602245797, 5248.6063545234065, 4044.352903535435, 4088.8364465421346, 4099.282625540533, 4104.8973775655695, 4129.9174016519655, 4075.3071977763702, 4089.427480152781, 4121.299379105544, 4138.379243113527, 4149.813258403379, 3819.694424446038, 3982.6614737747327, 4072.226277007374, 4072.9185416291657, 4086.549275007374, 4036.6568841648495, 4044.898877528056, 4061.2689715851134, 4068.4914385701786, 4070.5522392536795, 3633.2370202257293, 3633.582138054131, 3641.0715267606593, 3642.9817850910576, 3650.8539658413633, 4802.543758342987, 5053.242013697938, 5055.620828437882, 5075.137226671474, 5082.440931497532, 4603.0, 4613.261878099488, 4617.430073774933, 4623.606993405565, 4635.165670179366, 5393.139366918407, 5440.483154100354, 5444.700541470217, 5448.945510544883, 5469.261649677323, 3704.240630670706, 3909.394043923168, 3914.393269043303, 3920.4315374270573, 3925.8037098145264, 5643.407442218549, 5678.403767604384, 5696.2594862668, 5696.401877802854, 5702.887936852316, 4004.5795191505053, 4019.2765302245875, 4030.1133750574827, 4036.8183431745642, 4048.959510404917, 3884.261990221849, 4017.879463616096, 4051.959480405158, 4057.634812866797, 4062.5734297898885, 4580.770961451914, 4622.329762184464, 4627.745473998895, 4627.95372046282, 4640.69835460694, 5410.83767486976, 5412.296401467784, 5435.130379139318, 5470.863228419242, 5471.534919531884, 1276.6170148955275, 1316.394458549059, 1333.9666508337175, 1377.0704774277324, 1393.9442422303198, 873.4497266722052, 877.8814859993947, 885.8051228729669, 890.701614958996, 900.657750054988, 4688.991866748597, 4717.452575609202, 4725.9527404726205, 4731.976340118277, 4788.970371370103, 4904.852854414374, 4924.679895806761, 4956.603471722254, 4970.701757894538, 4980.726060066731, 4498.752568608693, 4719.834805781781, 4721.0, 4761.333413322138, 4806.831760888352, 2651.403434227322, 2654.7257316487808, 2665.813393062467, 2666.6133410655348, 2674.6790385153517, 5105.974470127626, 5118.436971933084, 5120.795168193231, 5122.564582010496, 5157.406898206679, 4758.7865094401395, 4918.852434426973, 5022.347094877716, 5057.229969510716, 5064.240363945438, 5076.263941728429, 5095.0, 5115.514026167508, 5127.538521533005, 5151.97424012885, 5006.549410553068, 5024.598032157492, 5029.371328583927, 5035.320231768665, 5048.334049763643, 4615.976920115378, 4870.245112007645, 4919.631027672867, 4977.328060711902, 4991.650584459053, 5066.594672426123, 5126.564242039469, 5173.534381905646, 5210.400803907599, 5237.895242095213, 3642.2533380657433, 3644.726645501545, 3658.6341365864264, 3669.7155995402463, 3713.7400381974085, 4809.9986756070375, 4922.827701030446, 4961.578265847299, 5028.64799464034, 5045.0, 4834.685745426536, 4846.466888642176, 4850.253908592974, 4852.272159176011, 4888.413390393175, 4709.670323077352, 4714.245720684674, 4822.276658501253, 4842.394700662418, 4914.886598762567, 4701.506341834195, 4742.573168414721, 4750.928736068892, 4766.80623981926, 4975.651704380659, 5478.643888147258, 5523.563873393027, 5564.8330550083565, 5589.217509548585, 5620.522255608155, 5443.292371991616, 5443.863903402446, 5478.808241711521, 5489.286392769074, 5504.422035686355], "value": 3967.053933547419, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [722.8084557592238, 747.8803391457365, 759.2255898983036, 814.4828034198282, 831.2311112221201, 15378.84621153788, 16328.510144695678, 16334.673306533863, 16345.346186152554, 16349.427770028036, 14705.191214483199, 14748.0, 14754.483593074245, 14780.408783648669, 14793.408263669467, 666.1306994372342, 776.8290975985274, 791.9485233459822, 800.9118996910364, 812.8333691593209, 797.8962734844491, 801.310872649521, 804.4288555125868, 804.8108694456827, 805.3235282362814, 848.8302339532119, 849.6346570974509, 849.9065102838683, 850.0776657326808, 850.9191626795445, 696.52984235641, 817.1746535998655, 842.1157784326464, 843.5191940593865, 848.1645579104577, 618.7803329817895, 619.8078595635322, 619.845038740315, 620.1503939602728, 620.6090163197202, 15200.771988420183, 15241.771373429407, 15243.39026438941, 15299.0, 15327.080375177526, 14317.85682143186, 14499.202543860083, 14563.271836408243, 14635.41458341665, 14749.557513274618, 12909.289989050598, 12944.352782360938, 13072.346382680827, 13175.143615665047, 13643.795343069862, 4404.757738324391, 4406.272964960777, 4440.689151759379, 4480.686351955364, 4588.4723256825555, 70843.29156708419, 73708.26291737122, 74424.0, 74602.0, 74770.0, 11159.497822598003, 11217.55129794799, 11321.603743868925, 11463.942680286546, 11564.595239166589, 21650.24224152147, 21663.783362166178, 21665.67501487479, 21694.0, 21714.782852171593, 8081.191880811872, 8181.181881811771, 8193.754187374388, 8329.08380078191, 8401.789955251046, 4440.555944405533, 4451.6661250405705, 4517.164324599959, 4565.5206203348835, 4647.86056418308, 3244.6917542833394, 3347.146477648184, 3353.3628610563915, 3354.4129777288877, 3356.1274068741814, 588.1236956934223, 588.6262223488116, 594.5778497266903, 604.6764980735286, 610.5848023344168, 587.9706014699248, 657.5495785387026, 667.9469810880672, 678.1613189890071, 710.8542748736496, 8881.156290152425, 8964.596593153325, 8978.595963181673, 8987.46075235475, 8993.325500587482, 582.944620261083, 587.6562211106551, 623.5603899251017, 664.3854434647932, 719.9964000179965, 4176.227397931392, 4273.18809426208, 4289.485261768607, 4329.328954012133, 4348.239058164809, 68560.6571967137, 69904.65047674831, 106213.0, 116805.0, 116950.41524792321, 96259.0, 96793.0, 98761.0, 98821.0, 98876.50561747146, 74716.62641686757, 76740.23259767443, 87885.56057219673, 88291.0, 89772.0, 10208.825985011521, 10243.033212888939, 10334.276600638184, 10529.210309226686, 10568.577256909637, 37530.62469375271, 39871.0, 46537.767311163225, 47464.0, 53265.20102198393, 74494.0, 76164.61917690375, 76568.61715691385, 78078.6096069516, 78884.21115788768, 12363.072769542141, 13084.177055068065, 13098.738025239632, 13222.867771322164, 13384.109364783813, 14274.785878212042, 14528.782068268772, 14623.85376146225, 14753.92623036878, 15038.097714137186, 14419.495317663832, 14654.56036318912, 14654.706905861609, 14685.55943321702, 14686.192259425834, 13870.722585548434, 14411.0, 14576.562703118923, 14626.853731462976, 14659.780103298246, 13816.654583635087, 13840.653983650489, 14230.715385692436, 14421.42314307416, 14916.328765205375, 10896.237263391486, 11232.7753444929, 11547.769044618892, 11624.82562761576, 11775.705607359885, 11732.413379330828, 11871.584494542649, 12076.0, 12119.394030298627, 12178.6955326114], "value": 7491.677252055452, "unit": "score"}], "name": "dromaeo_css", "value": 7161.173930687991, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 106.0, 110.0, 110.0, 109.0, 110.0, 110.0, 112.0, 113.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 132.0, 126.0, 178.0, 131.0, 132.0, 159.0, 126.0, 178.0, 125.0], "value": 144.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 163.0, 161.0, 164.0, 159.0, 159.0, 159.0, 160.0, 161.0], "value": 160.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 74.0, 75.0, 131.0, 76.0, 76.0, 76.0, 74.0, 99.0, 75.0], "value": 83.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 107.0, 84.0, 84.0, 84.0, 117.0, 85.0, 86.0, 141.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 116.0, 117.0, 116.0, 117.0, 116.0, 117.0], "value": 116.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 53.0, 54.0, 57.0, 54.0, 53.0, 54.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 62.0, 62.0, 62.0, 61.0, 62.0, 62.0, 62.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 79.0, 79.0, 80.0, 85.0, 82.0, 86.0, 88.0, 112.0, 87.0], "value": 86.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 126.0, 131.0, 120.0, 120.0, 120.0, 126.0, 122.0, 137.0, 134.0], "value": 126.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 162.0, 162.0, 163.0, 160.0, 163.0, 159.0, 162.0, 159.0, 160.0], "value": 163.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 65.0, 63.0, 63.0, 69.0, 63.0, 63.0, 66.0, 65.0], "value": 64.3, "unit": "score"}], "name": "kraken", "value": 1507.5, "alertThreshold": 2.0}]} 05:40:49 INFO - Return code: 0 05:40:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:40:49 ERROR - # TBPL SUCCESS # 05:40:49 INFO - Running post-action listener: _resource_record_post_action 05:40:49 INFO - ##### 05:40:49 INFO - ##### Finished run-tests step (success) 05:40:49 INFO - ##### 05:40:49 INFO - Running post-run listener: _resource_record_post_run 05:40:50 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 541323264; Read time: 168; Write time: 483032 05:40:50 INFO - TinderboxPrint: CPU usage
13.3% 05:40:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 05:40:50 INFO - TinderboxPrint: I/O write bytes / time
541,323,264 / 483,032 05:40:50 INFO - TinderboxPrint: CPU idle
8,248.4 (86.7%) 05:40:50 INFO - TinderboxPrint: CPU user
1,217.4 (12.8%) 05:40:50 INFO - TinderboxPrint: Swap in / out
0 / 0 05:40:50 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 248377344; Read time: 0; Write time: 301576 05:40:50 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 8192; Write bytes: 292945920; Read time: 168; Write time: 181456 05:40:50 INFO - Running post-run listener: _upload_blobber_files 05:40:50 INFO - Blob upload gear active. 05:40:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:40:50 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 05:40:50 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'] 05:40:50 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 05:40:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:55 INFO - (blobuploader) - INFO - Done attempting. 05:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:40:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:55 INFO - (blobuploader) - INFO - Done attempting. 05:40:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:40:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:40:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:40:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:40:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:40:56 INFO - (blobuploader) - INFO - Done attempting. 05:40:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:40:56 INFO - Return code: 0 05:40:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:40:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:40:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a80b3d2c91d88a8eed3a132679f32229f908163b47800c6b8b3117a9c90e893210420e75e58aef5e8c470d330c7c1f67b8c2f5be97d9d8c5bf60c14d8c610d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1608885eea62ca096aff08e55465a8b11877cde9b1e6d4169e0aaf06eeb2fc61e5893c622f3d39f3b05aa627a6b6573874afac12ccc9aca7122d0d0818273d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3e6e8cbd5cfafe7aef0fec33f6e949a8d6b545476e91fa65c93e01724082f8a6ddb2fee4d7b87f52824093a7b2b4b239d87a4236536bd84c24029e8d568d789"} 05:40:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:40:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:40:56 INFO - Contents: 05:40:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a80b3d2c91d88a8eed3a132679f32229f908163b47800c6b8b3117a9c90e893210420e75e58aef5e8c470d330c7c1f67b8c2f5be97d9d8c5bf60c14d8c610d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1608885eea62ca096aff08e55465a8b11877cde9b1e6d4169e0aaf06eeb2fc61e5893c622f3d39f3b05aa627a6b6573874afac12ccc9aca7122d0d0818273d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3e6e8cbd5cfafe7aef0fec33f6e949a8d6b545476e91fa65c93e01724082f8a6ddb2fee4d7b87f52824093a7b2b4b239d87a4236536bd84c24029e8d568d789"} 05:40:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:40:56 INFO - Copying logs to upload dir... 05:40:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:40:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.661048 ========= master_lag: 0.21 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-06 05:40:55.405527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:55.413179) ========= 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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 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/b4a80b3d2c91d88a8eed3a132679f32229f908163b47800c6b8b3117a9c90e893210420e75e58aef5e8c470d330c7c1f67b8c2f5be97d9d8c5bf60c14d8c610d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1608885eea62ca096aff08e55465a8b11877cde9b1e6d4169e0aaf06eeb2fc61e5893c622f3d39f3b05aa627a6b6573874afac12ccc9aca7122d0d0818273d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3e6e8cbd5cfafe7aef0fec33f6e949a8d6b545476e91fa65c93e01724082f8a6ddb2fee4d7b87f52824093a7b2b4b239d87a4236536bd84c24029e8d568d789"} build_url:https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010364 build_url: 'https://queue.taskcluster.net/v1/task/Ul6d5_VSS0aXJUFk87Kw_g/artifacts/public/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b4a80b3d2c91d88a8eed3a132679f32229f908163b47800c6b8b3117a9c90e893210420e75e58aef5e8c470d330c7c1f67b8c2f5be97d9d8c5bf60c14d8c610d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/1608885eea62ca096aff08e55465a8b11877cde9b1e6d4169e0aaf06eeb2fc61e5893c622f3d39f3b05aa627a6b6573874afac12ccc9aca7122d0d0818273d71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d3e6e8cbd5cfafe7aef0fec33f6e949a8d6b545476e91fa65c93e01724082f8a6ddb2fee4d7b87f52824093a7b2b4b239d87a4236536bd84c24029e8d568d789"}' ========= master_lag: 0.17 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:55.593221) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:55.593610) ========= 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=523ca41ca1e0623de333ad52000001bf-1465215387.235077-2110486379 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.11 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-06 05:40:55.705479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:40:55.706027) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-06 05:40:55.706475) ========= ========= Total master_lag: 0.55 =========