builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-008 starttime: 1458731643.27 results: success (0) buildid: 20160323025035 builduid: cb8f5569696c4314885f6f8923e5bd2d revision: efe7d026ac641759838dd3897c37892e37e5b244 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.272832) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.273304) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.273671) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006384 basedir: '/builds/slave/test' ========= master_lag: 0.14 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.423943) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.424557) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.720653) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.721481) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', '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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004524 ========= master_lag: 0.20 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.923341) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.923732) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.924147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:03.927682) ========= 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-03-23 04:14:04-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 61.2M=0s 2016-03-23 04:14:04 (61.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.418453 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:04.406398) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:04.406729) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017234 ========= master_lag: 0.11 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:04.536110) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:04.536523) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev efe7d026ac641759838dd3897c37892e37e5b244 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev efe7d026ac641759838dd3897c37892e37e5b244 --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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-03-23 04:14:04,687 truncating revision to first 12 chars 2016-03-23 04:14:04,687 Setting DEBUG logging. 2016-03-23 04:14:04,687 attempt 1/10 2016-03-23 04:14:04,687 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/efe7d026ac64?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 04:14:05,325 unpacking tar archive at: mozilla-central-efe7d026ac64/testing/mozharness/ program finished with exit code 0 elapsedTime=0.940976 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:05.532103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:05.532454) ========= echo efe7d026ac641759838dd3897c37892e37e5b244 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'efe7d026ac641759838dd3897c37892e37e5b244'] 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False efe7d026ac641759838dd3897c37892e37e5b244 program finished with exit code 0 elapsedTime=0.004704 script_repo_revision: 'efe7d026ac641759838dd3897c37892e37e5b244' ========= master_lag: 0.12 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:05.654453) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:05.654772) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 04:14:05.779886) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-23 04:14:05.780266) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:14:06 INFO - MultiFileLogger online at 20160323 04:14:06 in /builds/slave/test 04:14:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:14:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:14:06 INFO - {'append_to_log': False, 04:14:06 INFO - 'base_work_dir': '/builds/slave/test', 04:14:06 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:14:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:14:06 INFO - 'branch': 'Firefox-Non-PGO', 04:14:06 INFO - 'buildbot_json_path': 'buildprops.json', 04:14:06 INFO - 'config_files': ('talos/linux_config.py',), 04:14:06 INFO - 'default_actions': ('clobber', 04:14:06 INFO - 'read-buildbot-config', 04:14:06 INFO - 'download-and-extract', 04:14:06 INFO - 'populate-webroot', 04:14:06 INFO - 'create-virtualenv', 04:14:06 INFO - 'install', 04:14:06 INFO - 'run-tests'), 04:14:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:14:06 INFO - 'download_minidump_stackwalk': True, 04:14:06 INFO - 'download_symbols': 'ondemand', 04:14:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:14:06 INFO - 'tooltool.py': '/tools/tooltool.py', 04:14:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:14:06 INFO - '/tools/misc-python/virtualenv.py')}, 04:14:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:14:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:14:06 INFO - 'installer_path': 'installer.exe', 04:14:06 INFO - 'log_level': 'info', 04:14:06 INFO - 'log_name': 'talos', 04:14:06 INFO - 'log_to_console': True, 04:14:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:14:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:14:06 INFO - 'opt_config_files': (), 04:14:06 INFO - 'pip_index': False, 04:14:06 INFO - 'sps_profile': False, 04:14:06 INFO - 'sps_profile_interval': 0, 04:14:06 INFO - 'suite': 'dromaeojs', 04:14:06 INFO - 'system_bits': '32', 04:14:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:14:06 INFO - 'title': 'talos-linux64-ix-008', 04:14:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:14:06 INFO - 'use_talos_json': True, 04:14:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:14:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:14:06 INFO - 'work_dir': 'build'} 04:14:06 INFO - ##### 04:14:06 INFO - ##### Running clobber step. 04:14:06 INFO - ##### 04:14:06 INFO - Running pre-action listener: _resource_record_pre_action 04:14:06 INFO - Running main action method: clobber 04:14:06 INFO - rmtree: /builds/slave/test/build 04:14:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:14:06 INFO - Running post-action listener: _resource_record_post_action 04:14:06 INFO - ##### 04:14:06 INFO - ##### Running read-buildbot-config step. 04:14:06 INFO - ##### 04:14:06 INFO - Running pre-action listener: _resource_record_pre_action 04:14:06 INFO - Running main action method: read_buildbot_config 04:14:06 INFO - Using buildbot properties: 04:14:06 INFO - { 04:14:06 INFO - "project": "", 04:14:06 INFO - "product": "firefox", 04:14:06 INFO - "script_repo_revision": "production", 04:14:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:14:06 INFO - "repository": "", 04:14:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:14:06 INFO - "buildid": "20160323025035", 04:14:06 INFO - "pgo_build": "False", 04:14:06 INFO - "basedir": "/builds/slave/test", 04:14:06 INFO - "buildnumber": 524, 04:14:06 INFO - "slavename": "talos-linux64-ix-008", 04:14:06 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:14:06 INFO - "platform": "ubuntu64_hw", 04:14:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:14:06 INFO - "branch": "mozilla-central", 04:14:06 INFO - "repo_path": "mozilla-central", 04:14:06 INFO - "revision": "efe7d026ac641759838dd3897c37892e37e5b244", 04:14:06 INFO - "stage_platform": "linux64", 04:14:06 INFO - "builduid": "cb8f5569696c4314885f6f8923e5bd2d", 04:14:06 INFO - "slavebuilddir": "test" 04:14:06 INFO - } 04:14:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 04:14:06 INFO - Running post-action listener: _resource_record_post_action 04:14:06 INFO - ##### 04:14:06 INFO - ##### Running download-and-extract step. 04:14:06 INFO - ##### 04:14:06 INFO - Running pre-action listener: _resource_record_pre_action 04:14:06 INFO - Running main action method: download_and_extract 04:14:06 INFO - mkdir: /builds/slave/test/build/tests 04:14:06 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')]} 04:14:06 INFO - https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:14:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:14:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:14:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:14:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:14:11 INFO - Downloaded 1361 bytes. 04:14:11 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 04:14:11 INFO - Using the following test package requirements: 04:14:11 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:11 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:14:11 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:14:11 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'jsshell-linux-x86_64.zip'], 04:14:11 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:14:11 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 04:14:11 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:14:11 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:14:11 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:14:11 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 04:14:11 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:14:11 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:14:11 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')]} 04:14:11 INFO - https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:22 INFO - Downloaded 22037139 bytes. 04:14:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:14:23 INFO - Return code: 0 04:14:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:14:23 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')]} 04:14:23 INFO - https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:14:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 04:14:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:14:28 INFO - Downloaded 22037139 bytes. 04:14:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:14:30 INFO - Return code: 0 04:14: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')]} 04:14:30 INFO - https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:14:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 04:14:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:14:36 INFO - Downloaded 10848120 bytes. 04:14:36 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:14:36 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:14:36 INFO - Return code: 0 04:14:36 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')]} 04:14:36 INFO - https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:14:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:14:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:14:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:14:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:14:39 INFO - Downloaded 54258093 bytes. 04:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:14:39 INFO - mkdir: /builds/slave/test/properties 04:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 04:14:39 INFO - Contents: 04:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 04:14:40 INFO - Running post-action listener: _resource_record_post_action 04:14:40 INFO - Running post-action listener: set_extra_try_arguments 04:14:40 INFO - ##### 04:14:40 INFO - ##### Running populate-webroot step. 04:14:40 INFO - ##### 04:14:40 INFO - Running pre-action listener: _resource_record_pre_action 04:14:40 INFO - Running main action method: populate_webroot 04:14:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:14:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:14:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:14:40 INFO - '--tppagecycles', 04:14:40 INFO - '7'], 04:14:40 INFO - 'tests': ['tsvgm']}}, 04:14:40 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:14:40 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:14:40 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:14:40 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:14:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:14:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'tests': ['damp', 'tps']}, 04:14:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['damp', 'tps']}, 04:14:40 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:14:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:14:40 INFO - 'other': {'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'other_l64': {'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'other_nol64': {'tests': ['a11yr', 04:14:40 INFO - 'ts_paint', 04:14:40 INFO - 'tpaint', 04:14:40 INFO - 'sessionrestore', 04:14:40 INFO - 'sessionrestore_no_auto_restore', 04:14:40 INFO - 'tabpaint']}, 04:14:40 INFO - 'svgr': {'tests': ['tsvgx', 04:14:40 INFO - 'tsvgr_opacity', 04:14:40 INFO - 'tart', 04:14:40 INFO - 'tscrollx', 04:14:40 INFO - 'cart']}, 04:14:40 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['tsvgx', 04:14:40 INFO - 'tsvgr_opacity', 04:14:40 INFO - 'tart', 04:14:40 INFO - 'tscrollx', 04:14:40 INFO - 'cart']}, 04:14:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'tests': ['tp5o']}, 04:14:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'talos_options': ['--e10s'], 04:14:40 INFO - 'tests': ['tp5o']}, 04:14:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'talos_options': ['--xperf_path', 04:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:40 INFO - 'tests': ['tp5n']}, 04:14:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:14:40 INFO - 'talos_options': ['--e10s', 04:14:40 INFO - '--xperf_path', 04:14:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:14:40 INFO - 'tests': ['tp5n']}}, 04:14:40 INFO - 'talos.zip': {'path': '', 04:14:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:14:40 INFO - Running post-action listener: _resource_record_post_action 04:14:40 INFO - ##### 04:14:40 INFO - ##### Running create-virtualenv step. 04:14:40 INFO - ##### 04:14:40 INFO - Running pre-action listener: _resource_record_pre_action 04:14:40 INFO - Running main action method: create_virtualenv 04:14:40 INFO - Creating virtualenv /builds/slave/test/build/venv 04:14:40 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 04:14:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:14:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:14:40 INFO - Using real prefix '/usr' 04:14:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:14:40 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:42 INFO - Installing pip.................done. 04:14:42 INFO - Return code: 0 04:14:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14: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', 'pip>=1.5'] in /builds/slave/test/build 04:14: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 pip>=1.5 04:14:42 INFO - Using env: {'DISPLAY': ':0', 04:14:42 INFO - 'HOME': '/home/cltbld', 04:14:42 INFO - 'LANG': 'en_US.UTF-8', 04:14:42 INFO - 'LANGUAGE': 'en_US:en', 04:14:42 INFO - 'LOGNAME': 'cltbld', 04:14:42 INFO - 'MAIL': '/var/mail/cltbld', 04:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:42 INFO - 'MOZ_NO_REMOTE': '1', 04:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:42 INFO - 'NO_EM_RESTART': '1', 04:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:42 INFO - 'PWD': '/builds/slave/test', 04:14:42 INFO - 'SHELL': '/bin/bash', 04:14:42 INFO - 'SHLVL': '1', 04:14:42 INFO - 'TERM': 'linux', 04:14:42 INFO - 'TMOUT': '86400', 04:14:42 INFO - 'USER': 'cltbld', 04:14:42 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:42 INFO - '_': '/tools/buildbot/bin/python'} 04:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:42 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 04:14:42 INFO - Cleaning up... 04:14:42 INFO - Return code: 0 04:14:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:14: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 psutil>=0.7.1 04:14:42 INFO - Using env: {'DISPLAY': ':0', 04:14:42 INFO - 'HOME': '/home/cltbld', 04:14:42 INFO - 'LANG': 'en_US.UTF-8', 04:14:42 INFO - 'LANGUAGE': 'en_US:en', 04:14:42 INFO - 'LOGNAME': 'cltbld', 04:14:42 INFO - 'MAIL': '/var/mail/cltbld', 04:14:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:43 INFO - 'MOZ_NO_REMOTE': '1', 04:14:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:43 INFO - 'NO_EM_RESTART': '1', 04:14:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:43 INFO - 'PWD': '/builds/slave/test', 04:14:43 INFO - 'SHELL': '/bin/bash', 04:14:43 INFO - 'SHLVL': '1', 04:14:43 INFO - 'TERM': 'linux', 04:14:43 INFO - 'TMOUT': '86400', 04:14:43 INFO - 'USER': 'cltbld', 04:14:43 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:43 INFO - '_': '/tools/buildbot/bin/python'} 04:14:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:43 INFO - Downloading/unpacking psutil>=0.7.1 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:45 INFO - Installing collected packages: psutil 04:14:45 INFO - Running setup.py install for psutil 04:14:45 INFO - building 'psutil._psutil_linux' extension 04:14:45 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 04:14:45 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 04:14:45 INFO - building 'psutil._psutil_posix' extension 04:14:45 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 04:14:45 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 04:14:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:46 INFO - Successfully installed psutil 04:14:46 INFO - Cleaning up... 04:14:46 INFO - Return code: 0 04:14:46 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:14:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:14:46 INFO - Using env: {'DISPLAY': ':0', 04:14:46 INFO - 'HOME': '/home/cltbld', 04:14:46 INFO - 'LANG': 'en_US.UTF-8', 04:14:46 INFO - 'LANGUAGE': 'en_US:en', 04:14:46 INFO - 'LOGNAME': 'cltbld', 04:14:46 INFO - 'MAIL': '/var/mail/cltbld', 04:14:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:46 INFO - 'MOZ_NO_REMOTE': '1', 04:14:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:46 INFO - 'NO_EM_RESTART': '1', 04:14:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:46 INFO - 'PWD': '/builds/slave/test', 04:14:46 INFO - 'SHELL': '/bin/bash', 04:14:46 INFO - 'SHLVL': '1', 04:14:46 INFO - 'TERM': 'linux', 04:14:46 INFO - 'TMOUT': '86400', 04:14:46 INFO - 'USER': 'cltbld', 04:14:46 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:46 INFO - '_': '/tools/buildbot/bin/python'} 04:14:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:46 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:14:48 INFO - Installing collected packages: mozsystemmonitor 04:14:48 INFO - Running setup.py install for mozsystemmonitor 04:14:48 INFO - Successfully installed mozsystemmonitor 04:14:48 INFO - Cleaning up... 04:14:48 INFO - Return code: 0 04:14:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:48 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:48 INFO - Using env: {'DISPLAY': ':0', 04:14:48 INFO - 'HOME': '/home/cltbld', 04:14:48 INFO - 'LANG': 'en_US.UTF-8', 04:14:48 INFO - 'LANGUAGE': 'en_US:en', 04:14:48 INFO - 'LOGNAME': 'cltbld', 04:14:48 INFO - 'MAIL': '/var/mail/cltbld', 04:14:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:48 INFO - 'MOZ_NO_REMOTE': '1', 04:14:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:48 INFO - 'NO_EM_RESTART': '1', 04:14:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:48 INFO - 'PWD': '/builds/slave/test', 04:14:48 INFO - 'SHELL': '/bin/bash', 04:14:48 INFO - 'SHLVL': '1', 04:14:48 INFO - 'TERM': 'linux', 04:14:48 INFO - 'TMOUT': '86400', 04:14:48 INFO - 'USER': 'cltbld', 04:14:48 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:48 INFO - '_': '/tools/buildbot/bin/python'} 04:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:48 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:51 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14: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 04:14:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:52 INFO - Downloading docopt-0.6.1.tar.gz 04:14:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:52 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:52 INFO - Running setup.py install for blobuploader 04:14:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:52 INFO - Running setup.py install for requests 04:14:52 INFO - Running setup.py install for docopt 04:14:52 INFO - Successfully installed blobuploader requests docopt 04:14:52 INFO - Cleaning up... 04:14:53 INFO - Return code: 0 04:14:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:53 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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14:53 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 04:14:53 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 04:14:53 INFO - Using env: {'DISPLAY': ':0', 04:14:53 INFO - 'HOME': '/home/cltbld', 04:14:53 INFO - 'LANG': 'en_US.UTF-8', 04:14:53 INFO - 'LANGUAGE': 'en_US:en', 04:14:53 INFO - 'LOGNAME': 'cltbld', 04:14:53 INFO - 'MAIL': '/var/mail/cltbld', 04:14:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:53 INFO - 'MOZ_NO_REMOTE': '1', 04:14:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:53 INFO - 'NO_EM_RESTART': '1', 04:14:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:53 INFO - 'PWD': '/builds/slave/test', 04:14:53 INFO - 'SHELL': '/bin/bash', 04:14:53 INFO - 'SHLVL': '1', 04:14:53 INFO - 'TERM': 'linux', 04:14:53 INFO - 'TMOUT': '86400', 04:14:53 INFO - 'USER': 'cltbld', 04:14:53 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:53 INFO - '_': '/tools/buildbot/bin/python'} 04:14:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:53 INFO - Running setup.py (path:/tmp/pip-0K6RWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:53 INFO - Running setup.py (path:/tmp/pip-ZsubCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:53 INFO - Running setup.py (path:/tmp/pip-6eYxNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:53 INFO - Running setup.py (path:/tmp/pip-DJt3Us-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:53 INFO - Running setup.py (path:/tmp/pip-ShzpUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:53 INFO - Running setup.py (path:/tmp/pip-7WsnCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:53 INFO - Running setup.py (path:/tmp/pip-bIdiYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:53 INFO - Running setup.py (path:/tmp/pip-74FFUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:53 INFO - Running setup.py (path:/tmp/pip-mbenyt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:53 INFO - Running setup.py (path:/tmp/pip-cfkmLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:53 INFO - Running setup.py (path:/tmp/pip-Z5O0oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:54 INFO - Running setup.py (path:/tmp/pip-bSyCut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:54 INFO - Running setup.py (path:/tmp/pip-PYKf2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:54 INFO - Running setup.py (path:/tmp/pip-00lm9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:54 INFO - Running setup.py (path:/tmp/pip-SP8UJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:54 INFO - Running setup.py (path:/tmp/pip-APmRcT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:54 INFO - Running setup.py (path:/tmp/pip-VtB4NN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:54 INFO - Running setup.py install for manifestparser 04:14:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:54 INFO - Running setup.py install for mozcrash 04:14:54 INFO - Running setup.py install for mozdebug 04:14:54 INFO - Running setup.py install for mozdevice 04:14:54 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:54 INFO - Running setup.py install for mozfile 04:14:55 INFO - Running setup.py install for mozhttpd 04:14:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozinfo 04:14:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozInstall 04:14:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozleak 04:14:55 INFO - Running setup.py install for mozlog 04:14:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for moznetwork 04:14:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozprocess 04:14:55 INFO - Running setup.py install for mozprofile 04:14:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozrunner 04:14:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:55 INFO - Running setup.py install for mozscreenshot 04:14:56 INFO - Running setup.py install for moztest 04:14:56 INFO - Running setup.py install for mozversion 04:14:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:56 INFO - Cleaning up... 04:14:56 INFO - Return code: 0 04:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:56 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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:14:56 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 04:14:56 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 04:14:56 INFO - Using env: {'DISPLAY': ':0', 04:14:56 INFO - 'HOME': '/home/cltbld', 04:14:56 INFO - 'LANG': 'en_US.UTF-8', 04:14:56 INFO - 'LANGUAGE': 'en_US:en', 04:14:56 INFO - 'LOGNAME': 'cltbld', 04:14:56 INFO - 'MAIL': '/var/mail/cltbld', 04:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:56 INFO - 'MOZ_NO_REMOTE': '1', 04:14:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:56 INFO - 'NO_EM_RESTART': '1', 04:14:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:56 INFO - 'PWD': '/builds/slave/test', 04:14:56 INFO - 'SHELL': '/bin/bash', 04:14:56 INFO - 'SHLVL': '1', 04:14:56 INFO - 'TERM': 'linux', 04:14:56 INFO - 'TMOUT': '86400', 04:14:56 INFO - 'USER': 'cltbld', 04:14:56 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:56 INFO - '_': '/tools/buildbot/bin/python'} 04:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:56 INFO - Running setup.py (path:/tmp/pip-t5Fe7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:56 INFO - Running setup.py (path:/tmp/pip-dMaQ81-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:56 INFO - Running setup.py (path:/tmp/pip-flbTi7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:56 INFO - Running setup.py (path:/tmp/pip-FwZBOL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:56 INFO - Running setup.py (path:/tmp/pip-cqi1Lz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:56 INFO - Running setup.py (path:/tmp/pip-d7MEjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:56 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)) 04:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:56 INFO - Running setup.py (path:/tmp/pip-1jEhkx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:57 INFO - Running setup.py (path:/tmp/pip-u6GPMT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:57 INFO - Running setup.py (path:/tmp/pip-aLYY45-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:57 INFO - Running setup.py (path:/tmp/pip-fHC9fX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:57 INFO - Running setup.py (path:/tmp/pip-f7G67K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:57 INFO - Running setup.py (path:/tmp/pip-XDQKPS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:57 INFO - Running setup.py (path:/tmp/pip-wISxi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:57 INFO - Running setup.py (path:/tmp/pip-HgGzkF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:57 INFO - Running setup.py (path:/tmp/pip-AUERc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:57 INFO - Running setup.py (path:/tmp/pip-nPGAMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:57 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)) 04:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:57 INFO - Running setup.py (path:/tmp/pip-lO7L4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:57 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)) 04:14:57 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)) 04:14:57 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)) 04:14:57 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)) 04:14:57 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)) 04:14:57 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)) 04:14:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:57 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 04:14:59 INFO - Downloading blessings-1.6.tar.gz 04:14:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:59 INFO - Installing collected packages: blessings 04:14:59 INFO - Running setup.py install for blessings 04:14:59 INFO - Successfully installed blessings 04:14:59 INFO - Cleaning up... 04:15:00 INFO - Return code: 0 04:15:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:15:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:00 INFO - Reading from file tmpfile_stdout 04:15:00 INFO - Current package versions: 04:15:00 INFO - argparse == 1.2.1 04:15:00 INFO - blessings == 1.6 04:15:00 INFO - blobuploader == 1.2.4 04:15:00 INFO - docopt == 0.6.1 04:15:00 INFO - manifestparser == 1.1 04:15:00 INFO - mozInstall == 1.12 04:15:00 INFO - mozcrash == 0.17 04:15:00 INFO - mozdebug == 0.1 04:15:00 INFO - mozdevice == 0.48 04:15:00 INFO - mozfile == 1.2 04:15:00 INFO - mozhttpd == 0.7 04:15:00 INFO - mozinfo == 0.9 04:15:00 INFO - mozleak == 0.1 04:15:00 INFO - mozlog == 3.1 04:15:00 INFO - moznetwork == 0.27 04:15:00 INFO - mozprocess == 0.22 04:15:00 INFO - mozprofile == 0.28 04:15:00 INFO - mozrunner == 6.11 04:15:00 INFO - mozscreenshot == 0.1 04:15:00 INFO - mozsystemmonitor == 0.0 04:15:00 INFO - moztest == 0.7 04:15:00 INFO - mozversion == 1.4 04:15:00 INFO - psutil == 3.1.1 04:15:00 INFO - requests == 1.2.3 04:15:00 INFO - wsgiref == 0.1.2 04:15:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:15:00 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 04:15:00 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 04:15:00 INFO - Using env: {'DISPLAY': ':0', 04:15:00 INFO - 'HOME': '/home/cltbld', 04:15:00 INFO - 'LANG': 'en_US.UTF-8', 04:15:00 INFO - 'LANGUAGE': 'en_US:en', 04:15:00 INFO - 'LOGNAME': 'cltbld', 04:15:00 INFO - 'MAIL': '/var/mail/cltbld', 04:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:00 INFO - 'MOZ_NO_REMOTE': '1', 04:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:00 INFO - 'NO_EM_RESTART': '1', 04:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:00 INFO - 'PWD': '/builds/slave/test', 04:15:00 INFO - 'SHELL': '/bin/bash', 04:15:00 INFO - 'SHLVL': '1', 04:15:00 INFO - 'TERM': 'linux', 04:15:00 INFO - 'TMOUT': '86400', 04:15:00 INFO - 'USER': 'cltbld', 04:15:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:00 INFO - '_': '/tools/buildbot/bin/python'} 04:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 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)) 04:15:00 INFO - Cleaning up... 04:15:00 INFO - Return code: 0 04:15:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:00 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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:15:00 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 04:15:00 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 04:15:00 INFO - Using env: {'DISPLAY': ':0', 04:15:00 INFO - 'HOME': '/home/cltbld', 04:15:00 INFO - 'LANG': 'en_US.UTF-8', 04:15:00 INFO - 'LANGUAGE': 'en_US:en', 04:15:00 INFO - 'LOGNAME': 'cltbld', 04:15:00 INFO - 'MAIL': '/var/mail/cltbld', 04:15:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:00 INFO - 'MOZ_NO_REMOTE': '1', 04:15:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:00 INFO - 'NO_EM_RESTART': '1', 04:15:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:00 INFO - 'PWD': '/builds/slave/test', 04:15:00 INFO - 'SHELL': '/bin/bash', 04:15:00 INFO - 'SHLVL': '1', 04:15:00 INFO - 'TERM': 'linux', 04:15:00 INFO - 'TMOUT': '86400', 04:15:00 INFO - 'USER': 'cltbld', 04:15:00 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:15:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:00 INFO - '_': '/tools/buildbot/bin/python'} 04:15:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:00 INFO - Downloading/unpacking jsonschema 04:15:00 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 04:15:00 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 04:15:00 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 04:15:00 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 04:15:00 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 04:15:00 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 04:15:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:15:03 INFO - Downloading/unpacking functools32 (from jsonschema) 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 INFO - Downloading functools32-3.2.3-2.tar.gz 04:15:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:15:03 INFO - warning: no files found matching '*.txt' 04:15:03 INFO - no previously-included directories found matching 'build' 04:15:03 INFO - no previously-included directories found matching 'dist' 04:15:03 INFO - no previously-included directories found matching '.git*' 04:15:03 INFO - Installing collected packages: jsonschema, functools32 04:15:03 INFO - Running setup.py install for functools32 04:15:03 INFO - warning: no files found matching '*.txt' 04:15:03 INFO - no previously-included directories found matching 'build' 04:15:03 INFO - no previously-included directories found matching 'dist' 04:15:03 INFO - no previously-included directories found matching '.git*' 04:15:03 INFO - Successfully installed jsonschema functools32 04:15:03 INFO - Cleaning up... 04:15:03 INFO - Return code: 0 04:15:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:03 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 0x7fbf49ea0f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dab8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e765a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, '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': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', '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 04:15:03 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 04:15:03 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 04:15:03 INFO - Using env: {'DISPLAY': ':0', 04:15:03 INFO - 'HOME': '/home/cltbld', 04:15:03 INFO - 'LANG': 'en_US.UTF-8', 04:15:03 INFO - 'LANGUAGE': 'en_US:en', 04:15:03 INFO - 'LOGNAME': 'cltbld', 04:15:03 INFO - 'MAIL': '/var/mail/cltbld', 04:15:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:03 INFO - 'MOZ_NO_REMOTE': '1', 04:15:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:03 INFO - 'NO_EM_RESTART': '1', 04:15:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:03 INFO - 'PWD': '/builds/slave/test', 04:15:03 INFO - 'SHELL': '/bin/bash', 04:15:03 INFO - 'SHLVL': '1', 04:15:03 INFO - 'TERM': 'linux', 04:15:03 INFO - 'TMOUT': '86400', 04:15:03 INFO - 'USER': 'cltbld', 04:15:03 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:15:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:03 INFO - '_': '/tools/buildbot/bin/python'} 04:15:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:03 INFO - Downloading/unpacking flake8 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:03 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 04:15:05 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:15:05 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:15:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 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 04:15:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:06 INFO - no previously-included directories found matching 'docs/_build' 04:15:06 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:15:06 INFO - Running setup.py install for pep8 04:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:15:06 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:15:06 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:15:06 INFO - no previously-included directories found matching 'docs/_build' 04:15:06 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:15:06 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:15:06 INFO - Cleaning up... 04:15:06 INFO - Return code: 0 04:15:06 INFO - Running post-action listener: _resource_record_post_action 04:15:06 INFO - Running post-action listener: _start_resource_monitoring 04:15:06 INFO - Starting resource monitoring. 04:15:06 INFO - ##### 04:15:06 INFO - ##### Running install step. 04:15:06 INFO - ##### 04:15:06 INFO - Running pre-action listener: _resource_record_pre_action 04:15:06 INFO - Running main action method: install 04:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:15:07 INFO - Reading from file tmpfile_stdout 04:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 04:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:15:07 INFO - Reading from file tmpfile_stdout 04:15:07 INFO - Output received: 04:15:07 INFO - Usage: mozinstall [options] installer 04:15:07 INFO - Options: 04:15:07 INFO - -h, --help show this help message and exit 04:15:07 INFO - -d DEST, --destination=DEST 04:15:07 INFO - Directory to install application into. [default: 04:15:07 INFO - "/builds/slave/test"] 04:15:07 INFO - --app=APP Application being installed. [default: firefox] 04:15:07 INFO - mkdir: /builds/slave/test/build/application 04:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:15:22 INFO - Reading from file tmpfile_stdout 04:15:22 INFO - Output received: 04:15:22 INFO - /builds/slave/test/build/application/firefox/firefox 04:15:22 INFO - Running post-action listener: _resource_record_post_action 04:15:22 INFO - ##### 04:15:22 INFO - ##### Running run-tests step. 04:15:22 INFO - ##### 04:15:22 INFO - Running pre-action listener: _resource_record_pre_action 04:15:22 INFO - Running main action method: run_tests 04:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:15:22 INFO - Python 2.7.3 04:15:22 INFO - Return code: 0 04:15:22 INFO - grabbing minidump binary from tooltool 04:15:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f05410>, '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 0x1f06310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f067a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:15:22 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 04:15:22 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 04:15:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:15:22 INFO - Return code: 0 04:15:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:15:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:15:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:15:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:15:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:15:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:15:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:15:23 INFO - Return code: 0 04:15:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:15:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --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 04:15:23 INFO - Using env: {'DISPLAY': ':0', 04:15:23 INFO - 'HOME': '/home/cltbld', 04:15:23 INFO - 'LANG': 'en_US.UTF-8', 04:15:23 INFO - 'LANGUAGE': 'en_US:en', 04:15:23 INFO - 'LOGNAME': 'cltbld', 04:15:23 INFO - 'MAIL': '/var/mail/cltbld', 04:15:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:15:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:15:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:23 INFO - 'MOZ_NO_REMOTE': '1', 04:15:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:15:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:23 INFO - 'NO_EM_RESTART': '1', 04:15:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:23 INFO - 'PWD': '/builds/slave/test', 04:15:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:15:23 INFO - 'SHELL': '/bin/bash', 04:15:23 INFO - 'SHLVL': '1', 04:15:23 INFO - 'TERM': 'linux', 04:15:23 INFO - 'TMOUT': '86400', 04:15:23 INFO - 'USER': 'cltbld', 04:15:23 INFO - 'XDG_SESSION_COOKIE': '32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496', 04:15:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:23 INFO - '_': '/tools/buildbot/bin/python'} 04:15:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--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 04:15:24 INFO - mozversion application_buildid: 20160323025035 04:15:24 INFO - mozversion application_changeset: efe7d026ac641759838dd3897c37892e37e5b244 04:15:24 INFO - mozversion application_display_name: Nightly 04:15:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:15:24 INFO - mozversion application_name: Firefox 04:15:24 INFO - mozversion application_remotingname: firefox 04:15:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:15:24 INFO - mozversion application_vendor: Mozilla 04:15:24 INFO - mozversion application_version: 48.0a1 04:15:24 INFO - mozversion platform_buildid: 20160323025035 04:15:24 INFO - mozversion platform_changeset: efe7d026ac641759838dd3897c37892e37e5b244 04:15:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:15:24 INFO - mozversion platform_version: 48.0a1 04:15:24 INFO - using testdate: 1458731724 04:15:24 INFO - actual date: 1458731724 04:15:24 INFO - starting webserver on 'localhost:46026' 04:15:24 INFO - SUITE-START | Running 2 tests 04:15:24 INFO - TEST-START | dromaeo_css 04:15:24 INFO - operating with platform_type : linux_ 04:15:24 INFO - Initialising browser for dromaeo_css test... 04:15:24 INFO - TEST-INFO | started process 3937 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0jVEIk/profile http://localhost:46026/getInfo.html) 04:15:28 INFO - PROCESS | 3937 | __metrics Screen width/height:1600/1200 04:15:28 INFO - PROCESS | 3937 | colorDepth:24 04:15:28 INFO - PROCESS | 3937 | Browser inner width/height: 1024/697 04:15:28 INFO - PROCESS | 3937 | __metrics 04:15:29 ERROR - PROCESS | 3937 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:15:30 INFO - TEST-INFO | 3937: exit 0 04:15:30 INFO - Browser initialized. 04:15:30 INFO - Running cycle 1/1 for dromaeo_css test... 04:15:30 INFO - TEST-INFO | started process 4032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0jVEIk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:15:42 INFO - PROCESS | 4032 | RSS: Main: 157601792 04:15:42 INFO - PROCESS | 4032 | 04:16:33 INFO - PROCESS | 4032 | 1458731793541 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] 04:18:44 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46026/tests/dromaeo/cssquery-ext.html) 04:18:45 INFO - PROCESS | 4032 | RSS: Main: 243310592 04:18:45 INFO - PROCESS | 4032 | 04:21:48 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-ext.html (next: http://localhost:46026/tests/dromaeo/cssquery-jquery.html) 04:21:48 INFO - PROCESS | 4032 | RSS: Main: 234754048 04:21:48 INFO - PROCESS | 4032 | 04:24:50 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46026/tests/dromaeo/cssquery-mootools.html) 04:24:51 INFO - PROCESS | 4032 | RSS: Main: 238596096 04:24:51 INFO - PROCESS | 4032 | 04:27:53 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46026/tests/dromaeo/cssquery-prototype.html) 04:27:53 INFO - PROCESS | 4032 | RSS: Main: 208568320 04:27:53 INFO - PROCESS | 4032 | 04:30:56 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46026/tests/dromaeo/cssquery-yui.html) 04:30:57 INFO - PROCESS | 4032 | RSS: Main: 221937664 04:30:57 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | Cycle 1(1): loaded http://localhost:46026/tests/dromaeo/cssquery-yui.html (next: http://localhost:46026/tests/dromaeo/cssquery-dojo.html) 04:33:59 INFO - PROCESS | 4032 | RSS: Main: 274649088 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | __start_tp_report 04:33:59 INFO - PROCESS | 4032 | _x_x_mozilla_page_load 04:33:59 INFO - PROCESS | 4032 | _x_x_mozilla_page_load_details 04:33:59 INFO - PROCESS | 4032 | |i|pagename|runs| 04:33:59 INFO - PROCESS | 4032 | |0;dojo.html;2608.7260837612052;2671.185288487013;2674.8436844523453;2685.154176434422;2710.76958458531;4531.63746900248;4612.285095810146;4661.4639316478615;4666.603338716209;4691.202495575756;4704.6706730528795;4706.741129237899;4735.242361222206;4755.690880092791;4794.208955522335;4226.535081141072;4318.417013703149;4378.8686339409705;4400.559944005606;4419.712718673276;4368.803403846835;4398.340248962665;4418.447694038246;4420.580044895746;4462.375267462541;4238.08881090564;4253.63844073251;4326.264535029021;4354.629856462205;4367.410399596046;4330.653547716175;4340.804663790137;4348.695591308609;4385.802638881258;4406.383106365111;4185.811638476245;4335.024619460628;4341.131773645284;4343.891402714926;4384.123175364908;4576.725396476222;4607.631389488833;4669.579737823578;4712.293156026623;4716.882077948045;5037.571806396424;5064.848054558369;5071.670341427795;5116.079105760999;5120.334356533627;4934;5084.262781896641;5104.259882317043;5106.361704786902;5107.438181799999;4717.410323709536;4745.383100196952;4765.475797662254;4799.496052914464;4804;5227.3465816772905;5245.0558899398475;5248.790048398021;5250.238715386247;5259.132243179909;4821.132196204717;4963.801447942042;5033.697978121324;5033.949660503348;5069.036882992294;4952.232403977389;4981.875453113701;4983.526564976321;5027.1956486962645;5031.396232452129;4962.826301079517;4966.701997880139;4972.57733092684;4974.253861920741;5018.648694591344;4877;4975.0547395994645;5013.097642424399;5021.472745361684;5063.797448102035;4246.596573325529;4254.276772948606;4265.0616864289805;4277.123189746157;4280.657547396201;3724.0875985383755;3745.3445647011663;3746.756460830037;3769.86805461813;3789.7157713171073;4257.510386305615;4326.848560300375;4343.3484977253665;4345.304751239786;4417.646588272994;5033.219850923113;5069.290299358093;5070.898582028339;5075.619328550373;5112;4335.132973405269;4337.0892112656065;4339.088791353788;4383.101464199832;4383.9342409863875;4478.1715382653665;4530.97734511332;4558.133954548625;4579.084183163381;4609.331646911179;4691.366665500251;4702.553257440538;4704.482506924167;4711.458182309078;4754.286856971482;4978.153713868579;5006.123928312458;5019.974900125476;5020.322256495327;5068.138416469135;4663.417072865892;4764.190087685032;4794.2808578713475;4809.951900480951;4847.684900481458;4992.850214493571;5005.074061298671;5024.472430394756;5027.27104569828;5081.5426611605135;4832.806687732451;5070.797168113234;5088.9567638634735;5103.821366252312;5119.308893299357;4894.755262236803;4934.753262336797;4959.057779021974;4987;5003.1744762115295;4886.53577910098;4928.457869634266;4928.901421971612;4929.359183306147;4970.7514624267915;4666.743329116931;4808.663393562417;4842.346283251716;4845.418549773909;4902.264660300983;4945.282933974481;4960.70235785854;4982.078315511642;5013.623978201576;5016.046951079284;4841.8547443576745;4844.733539655353;4847.927281090716;4860.1008813369635;4865.56209941107 04:33:59 INFO - PROCESS | 4032 | |1;ext.html;502.14133831148735;522.5636593444474;527.0723526593194;536.1047051424122;549.7059073395734;27089.864550677245;27585.862070689644;27586.17241482756;34363.140921476974;34708.65291347092;37936.43095353572;38449;38462.80768596153;38492;38544.22911541768;7740.8838867417035;7895.960520197391;7919.8416031679335;7923.049234091917;7928.9603551982445;7716.382689384864;7844.764657060269;7845.529268243895;7846.4899781514305;7847.176046515119;7782.805429864242;7890.3293220076075;7896.644650990719;8085.312748416362;8089.393295502831;7948;8013.879791803157;8016.318612917909;8023.157568455286;8023.237792409741;7895.881561776578;8030.23712747288;8034.357251419872;8034.919650803476;8037.758867233933;38535;39082.41376379328;39094;39128;39130.60869391298;3004.3690824926794;3069.294062365668;3437.8796742113905;3803.7527560708463;3845.8461661533506;29207.415851682847;29352.119436416942;29396.559051614244;29427.705722942712;29698.85150574255;3128.8279144647036;3129.6557378688326;3172.460681684096;3222.081706713599;3245.042712399848;239885;240225;240438;240602.7969860157;241596;41003.7949810255;42051.15897682029;42138.78930605327;54570.18144727832;55827;39860.601393985686;39996.80001599973;40030;40117.398239026435;40152.19695606072;13097.279649619171;13233.867661323264;13260.204387736767;13260.40328185234;13271.137376070525;10310.690679279634;10351.378917264989;10359.585616575403;10369.896301037044;10372.844407333896;14590.708185836223;14629.561113166623;14669.706605867823;14718.779218311734;14945;5688.63023903445;5804.883902322014;5837.211976383219;5860.736266868002;5921.289445266596;865.904750477447;907.8774365460711;930.8417569013284;943.6036864516919;996.2080146283722;27164.592531112048;27675.723242767315;27681.307967300574;27940.44119117606;28082.578761318597;780.8438312337555;972.5866506734609;987.782687808681;995.8854731705802;998.6354980432089;12505.687357816127;12629;12773.872261277269;12782.552610658582;12917.354132293536;269162;273240;274023;274283;274774;41626.791866040476;41632.58367416348;41656.791716041225;42600.57399425966;42717.78641106775;1035.2028937718067;1130.9660710178707;1219.0186899545774;1232.8520577530753;1239.0954603139578;24277.393065172804;24534.386640334134;25515.234542963743;25534.48931021332;25559.616605750558;34610.653893460745;34961.82519087388;34986.475202871465;34990.12524686903;35005.82497087498;162939;163595;163945;164141;316626;31157;31733.8413307932;31739.84130079335;32107.678923210467;32142.357152856344;34768.130796730286;35984.460233097045;36213.45679814752;38301.233975320894;38692.80653596714;32716;33297.66702332946;33934.481054612195;34112.82943585266;34195.316093678484;33317;33365;33402.33195336128;33519.32961340808;33725;32568.34863302768;32768.344633106724;32771.67228327782;33085.83457082699;33089.66910330866;29708.960186394237;33784.831075844464;34719.82640086783;34874.12814679653;36845.44731828971;24605.87697061503;24896.50206995886;25119;25284;25326 04:33:59 INFO - PROCESS | 4032 | |2;jquery.html;343.5053522926985;346.31602584894836;351.9243362677024;357.7334885510295;361.81004972389474;14793.112413255212;15275.618109547253;15791.526254212393;15846.524604261862;15853.920730396361;15185.240737963086;15273;15515.767263491029;15700.842991570082;15746.685066298667;4411.713238639494;4546.454425468948;4558.954410455903;4563.361129441881;4577.290519969393;4390.912181756363;4450.5104438511735;4513.864584062483;4554.975130595622;4555.817767289304;4474.3064824952025;4529.524399938008;4538.931916021263;4541.523140070278;4542.205114105019;4584.335271385664;4589.24277494213;4604.1482325769675;5068.543831055223;5080.034793389244;4300.978495107535;4392;4414.404055452537;4424.159409712144;4424.756638384888;18793.718094228596;19255.711164332548;19659.311924082587;19663.311784087487;19690.40928772139;1890.8392786613153;1908.0459770114942;1948.6492431362349;2116.343933380657;2376.988115059431;8551.82896342076;8673.479591224546;8722.651093956234;8728.214460698568;8908.198262156437;1779.0837718574944;1803.765510483642;1860.38607259604;1877.4836919847014;1913.3685883658359;50177;58964.70517647384;60826.39173608296;63114;63116;9202.125798049176;9448.149666530046;9574.281928855364;10051.949740251252;10079.748006299902;12494.125411221308;12499.3750312484;12555.748885022249;12579.119461637598;12585.622431327074;7031.437485001187;7150.892736608955;7188.4968052235845;7276.63616819157;7446.292602202782;6914.239433662293;6944.756933507303;7038.964805175941;7050.083489146481;7184.066071410683;4123.628873401348;4187.581241875788;4308.030693094029;4350.912981740411;4378.233809083397;1731.437282883068;1762.7796525434321;1776.640869734654;1798.2627122879558;1856.0441372693074;819.5410570080774;862.8878245828128;884.2572239319003;890.701614958996;898;15977.281022354022;16128.677426451406;16275.348986040663;16401.1799410029;16519.174041297887;826.4793180296375;828.2918105020242;852.4672079950032;864.0365991919091;903.584351198443;8984.32617553686;9174.908250917539;9386.765330866783;9452.669156579486;9616.23070154386;375615;380947.4289428304;383579;390337;398030;62744.686276568325;63907.68046159833;65224;66669;70458.64770676114;941.5339406993583;950.1733491862125;958.3579002068631;987.2496902354262;991.4794732765356;14872.479463218735;15415.768763468333;15463.304151312994;15495.922520387327;15769.29038193307;26496.337591559593;27450.588241176;30970.23640908658;35013.12467188341;35335.17318614453;42051.57948420599;43869.34195986999;44459.55540444684;45793.313100304185;46909;7122.964385178041;7384;9860.704178874645;10141.84787228207;10192.235582331206;11429.257098288585;11542.480588373375;11850.644480665595;11952.223105498115;12390.5663301784;9987.500624968869;10507.31702439339;10718.946405267923;10797.352158870493;11281.379524126252;10318.17454603645;10677.199210059121;10825.837612435662;10913.563457461612;11117.666470005914;10333.689989300334;10929.508172132431;11021.724456888322;11095;11160.609378672032;10723.517441714985;10815.459227038775;10880.161409536506;10930.617428389969;11032.393218373067;10767.138628909825;10853.78292434131;10856.240063195817;10945.616903408343;11059.944700276446 04:33:59 INFO - PROCESS | 4032 | |3;mootools.html;1244.1850587864951;1389.16650009994;1403.151093588379;1517.946871859485;1707.0525858148721;7311;7473.103227612681;7489.662965166567;7492.063492063492;7496.175420703725;7349.485536012481;7547.16981132075;7551.773446796591;7552.96223518883;7562.205968373324;1915.9042047897549;2144.15305954148;2208.1719355241785;2224.254874617005;2254.211026140854;2216.357256395643;2224.555088982202;2228.4206106412366;2229.7435794883636;2230.475838178027;2060.1759296281457;2150.5268840855065;2154.310620601408;2154.666026765854;2155.008695999842;2146.6565349544;2151.354593621915;2165.852098387857;2222.744384395799;2224.288227767115;2185.825133989277;2186.256672731279;2193.0350645715835;2203.4271089516683;2203.603351396748;7665.8850117248285;7708.229177082303;7732.6906923723545;7745.264199901;7750.922490775133;4584;4712.198926182557;4717.410323709536;4718.386609740712;4718.575328220442;2938.353562216309;3072.554479600468;3090.90727278182;3147.291859331655;3160.6365267994247;942.9292803039731;946.7159852044427;960.351762560269;979.7893452907659;996.5913975270176;10290.485475726258;10383.792324153475;10384.792304153874;10414.687559373231;10415.531301091394;3958.762474251554;4086.244044851712;4134;4172.207280616733;4177.143685544517;8196.13940536247;8343.624536895853;8403.789905252417;8404.159584041668;8405.285550728135;3995.6004399560393;4642;4648.047150334173;4668.5798278155125;4672.065586882569;4103.076807718239;4120.052387950788;4161.667066634662;4178.811953462041;4214.557471465452;3260.0871755908383;3344.080377896098;3355.7147642450177;3366.225768073357;3383.8308084595674;1024.9897501025043;1045.0803293102174;1046.9162467002623;1054.8206804843196;1055.2718624149313;999.4453078541334;1019.5259204469809;1023.0281232828694;1077.7952189084049;1188.7622475504934;7231.529950553302;7261.3827824634445;7262.564246145248;7274.781756547312;7288.416926645856;429.63266407221374;435.17317097514973;435.507876100005;435.7690424075245;435.8975640724427;5661.2923384576925;5674.744636491368;5734.111212762028;5738.942610573924;5749.137629355547;8854.690085847093;9064.818703626022;9087.81824363509;9103.408278462011;9105.81788364229;8762.561871906379;8914.509701966324;8931.285497160212;8938.195562399414;8977.910220897838;6989.0564773755905;7058.011878337037;7063.187733410621;7101.502894797314;7117.288271172842;6856.24581296067;6859.382655560824;6909.412699920563;6958.269381714847;6964.582125072512;7977.880331794911;8001.519908805491;8124.431289809657;8219.301359384519;8225.300849427866;8327.625256863335;8424.410291279797;8617.569121544024;8641.351898607503;8641.395102342776;5485.177223416519;5631.8592035199445;5635.042042852643;6276.623402595859;6403.583767055126;7060.823479413056;7250.419966402781;7259.891101633374;7261;7261.564306141649;6427.228732551936;6555.639439830855;6581;6662.733490660513;6750.05499230118;5864.413558644102;6515.73937042513;6543.640099794557;6571.507136964842;6595;6501.4798816095545;6503.51223658237;6563.967180164069;6566.9014964776525;6578.407943285128;6117.235345581802;6151.907721384272;6231.719572619334;6236.34518375564;6244.375562443719;6173.6913154343;6192.473639740672;6211.782587609412;6217.595856269328;6219.968900155471 04:33:59 INFO - PROCESS | 4032 | |4;prototype.html;309.11901081916534;309.3951325159312;310.3513656458005;310.5698607428711;314.9968500314998;5226.96148502084;5329.840104796853;5337.14605663094;5337.946620533793;5352.866178345544;5291.2327712481665;5324.920126198101;5355.464453554642;5355.732213389334;5359.115745901921;3910.648041676249;3980.2039592081555;4064.4919385076864;4134.13183231521;4134.3178375567995;4070.0638853063815;4080.1431699343025;4084.4485994390675;4086.89782755432;4091.3453847384426;4031.415444760508;4039.515258169009;4041.575634558373;4045.939310910339;4054.2702313583545;3895.0067732728116;3955.564887862333;4055.574164712707;4068.145689405199;4086.1827634473225;3556.0220939241917;3561.1631266652316;3566.215432604849;3573.4103872860946;3573.6783689468075;5111.744412779346;5127.359080114986;5149.841285710722;5151.124308867502;5162.5095615916425;4713.858584242478;4721.126591580569;4722.7402492862875;4725.432948046222;4725.480197178307;5644.096944488862;5646.265985421869;5648.661080335193;5650.29371328584;5653.886922261532;3921.4117882317596;3925.3719404895364;3925.509311336083;3931.4889064421727;3931.6658084062888;5691.231683722686;5824.213731146326;5824.650520968756;5833.504152147073;5843.415658434123;3946.4869566956686;3953.9011524711536;3968.166684996183;3972.5431575368625;3978.5026871641044;4033.979830100831;4034.1528279061727;4034.204778873373;4037.6164264394833;4040.4949381327333;4659.347691323217;4662.743549104832;4666.789994450258;4670.5329467053025;4675.976620116878;5639.295088113986;5646.463585959327;5648.85877853057;5653.038983372837;5661.122526008476;1391.7146984868077;1422.9786553201711;1425.1805212002932;1425.49394964786;1426.9286535673175;909.4497828813472;949.7862980829258;953.8521529162991;970.1898914406408;973.090160699748;4891.584215341736;4899.877503062381;4911.214205727067;4915.0415668944215;4920.655554111249;5830.504407125357;5833.270841144857;5842.532597392198;5845.240118784616;5847.152162936435;4908.386451693538;4914.8034078637165;4916.483769204254;4918.409790825052;4919.901601968012;3091.180837078176;3131.7024882636115;3132.3265497918055;3135.6864313568462;3136.106209730216;5398.055340315429;5412.350517937873;5422.6475279106735;5425.593080518976;5436.646617969819;5762.279715035621;5923.851903702356;5961.135635332853;5962.046072628359;5969.910451343233;5378.085725426687;5399.406065332811;5412.864678383072;5418.729063546728;5431.565474762088;5812.360640329645;5821.738021789114;5825.825225243249;5827.9417205829095;5831.854203644773;5710.314762228393;5713.143028545752;5715.8571035724435;5723.427657234243;5727.226824378656;5409.134538473825;5417.783288668409;5424.294841670558;5427.077396842467;5428.45715428454;3893.0851249956804;4005.69957253213;4014.2573623879675;4014.759114453142;4021.215862906822;5600.103983362643;5764.913526297025;5773.5092517134835;5780.335261444988;5790.971045144747;5508.228847961209;5606;5629.211910332475;5639.830805075854;5686.090225564056;5623.465770751772;5624.775008999594;5628.183913332626;5628.831135065954;5667.943320566907;5540.501354877919;5543.861403464945;5545.889082218252;5549.084401073777;5549.1676248563035;5701.116326969326;5701.629394089371;5703.600747947604;5703.828885133453;5704.429557044428;5389.137737961907;5549.250851135206;5582.49757521825;5585.134304182858;5586.217929489793 04:33:59 INFO - PROCESS | 4032 | |5;yui.html;682.6382017530708;747.8691229034918;770.0528350129341;777.7161336112321;793.3573805217774;12365.56720514781;12481.126321157522;12534.623961281177;12567.183133096354;12601.621951341464;11938.641840744769;11988.280703157794;12001.399930003508;12009.339486328248;12027.879721202786;635.2218532297921;783.475071701961;799.60019990005;800.75977206838;801.5671537369814;778.3967425245423;781.6482582837746;785.1834092543747;787.4527203593505;787.9212078792132;829.6764261937849;832.342449464922;836.5691668790578;838.9580520973957;839.1692224697535;833.6207025803245;835.2566216067704;835.5488036460304;837.4054421360811;837.9120192379834;612.8406614280319;618.0698049435571;618.0975775367968;618.3877960818756;618.9071639254103;12546.121771476;12551.560695375709;12573.182743121759;12585.559505417266;12595.685107872285;12485.93757031218;12698.873011269861;12748.872511274862;12757.42591583381;12916.297202641303;9350.57922393494;9449.291303152222;9530.094641009093;9899.505024748805;9951.303408761389;2825.7739380849484;2884.754795842356;2890.7253810887933;2898.840563768992;2956.3200463893427;43837.56162438367;45715.542844571464;45734.31398529058;45741.77129114366;45778;9735.221182305399;9870.851937220947;10126.898731012743;10275.845862312071;10398.792024159475;17695.911520442573;17733.024683642267;17829.375971841182;17842.107894605477;17863.553411164823;6693.364130407604;6737.9663101685155;6814.761483348059;6829.931700683029;7023.227444981048;3767.453719210699;3824.3116239076676;3883.203943191639;3921.9607803921594;4036.495438070241;2954.5863579098946;2999;3001.7448516875875;3003.1441039303695;3018.320877802477;528.6933578524447;531.4897698209685;537.5377175628956;538.488435985815;544.7194694732216;537.4867002013068;600.8227572866015;605.306923572507;610.4322979628988;620.4292051312804;7281.308275713799;7601.467897247139;7640;7644.847103057908;7700.807479813049;509.9490050994945;591.2993103172754;608.054475290918;616.7902913009509;625.5464788028734;3592.3713350163616;3631.2555926035097;3641.927161456756;3664.486971823947;3670.2749707637367;53083.20375194375;53683.46316536863;54995.450045499834;55193.44806551883;55221.17168242479;43275.78362108232;45191.548084518734;47611.52388476071;48181.5181848177;51242.48757512377;43432;43572.564274357486;44224;44229.77885110618;44419;8178.1412951641605;8209.425340226366;8430.831383372175;8437.95781021091;8627.180417860292;31143.065708028797;31525.842370788;31618.367632647678;32346.514802278456;32417.837910810296;38490.80754596209;38687.41968870413;41355.58644413517;41393;41889;9907.653232136841;10094.798104038025;10517.158627309644;10687.625933092304;11153.386563739072;12286.815697764361;12512.624621261377;12517.874821251671;12539.686507837378;13007.609771706864;10898.40058796742;11257.49341279628;11382.975532202141;11716.765664686489;11993.760124797629;10968.725781855517;11130.610428635282;11151.609693660683;11186.608468703556;11194.272372295774;10272.743181420225;10467.581296748045;10812.891871081503;10830.783384332111;10842.837357439803;9560.187384072431;9736.367136136128;9854.408735475894;10358.792824143626;10544.736381590521;8777;9126.45241285525;9617.23062155012;9975.950120249352;10009.449480278654 04:33:59 INFO - PROCESS | 4032 | __end_tp_report 04:33:59 INFO - PROCESS | 4032 | __start_cc_report 04:33:59 INFO - PROCESS | 4032 | _x_x_mozilla_cycle_collect,832 04:33:59 INFO - PROCESS | 4032 | __end_cc_report 04:33:59 INFO - PROCESS | 4032 | __startTimestamp1458732839880__endTimestamp 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | ------- Summary: start ------- 04:33:59 INFO - PROCESS | 4032 | Number of tests: 6 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#0] dojo.html Cycles:165 Average:4666.88 Median:4799.50 stddev:486.34 (10.1%) stddev-sans-first:460.26 04:33:59 INFO - PROCESS | 4032 | Values: 2608.7 2671.2 2674.8 2685.2 2710.8 4531.6 4612.3 4661.5 4666.6 4691.2 4704.7 4706.7 4735.2 4755.7 4794.2 4226.5 4318.4 4378.9 4400.6 4419.7 4368.8 4398.3 4418.4 4420.6 4462.4 4238.1 4253.6 4326.3 4354.6 4367.4 4330.7 4340.8 4348.7 4385.8 4406.4 4185.8 4335.0 4341.1 4343.9 4384.1 4576.7 4607.6 4669.6 4712.3 4716.9 5037.6 5064.8 5071.7 5116.1 5120.3 4934.0 5084.3 5104.3 5106.4 5107.4 4717.4 4745.4 4765.5 4799.5 4804.0 5227.3 5245.1 5248.8 5250.2 5259.1 4821.1 4963.8 5033.7 5033.9 5069.0 4952.2 4981.9 4983.5 5027.2 5031.4 4962.8 4966.7 4972.6 4974.3 5018.6 4877.0 4975.1 5013.1 5021.5 5063.8 4246.6 4254.3 4265.1 4277.1 4280.7 3724.1 3745.3 3746.8 3769.9 3789.7 4257.5 4326.8 4343.3 4345.3 4417.6 5033.2 5069.3 5070.9 5075.6 5112.0 4335.1 4337.1 4339.1 4383.1 4383.9 4478.2 4531.0 4558.1 4579.1 4609.3 4691.4 4702.6 4704.5 4711.5 4754.3 4978.2 5006.1 5020.0 5020.3 5068.1 4663.4 4764.2 4794.3 4810.0 4847.7 4992.9 5005.1 5024.5 5027.3 5081.5 4832.8 5070.8 5089.0 5103.8 5119.3 4894.8 4934.8 4959.1 4987.0 5003.2 4886.5 4928.5 4928.9 4929.4 4970.8 4666.7 4808.7 4842.3 4845.4 4902.3 4945.3 4960.7 4982.1 5013.6 5016.0 4841.9 4844.7 4847.9 4860.1 4865.6 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#1] ext.html Cycles:180 Average:38780.73 Median:34154.07 stddev:62834.22 (184.0%) stddev-sans-first:62944.76 04:33:59 INFO - PROCESS | 4032 | Values: 502.1 522.6 527.1 536.1 549.7 27089.9 27585.9 27586.2 34363.1 34708.7 37936.4 38449.0 38462.8 38492.0 38544.2 7740.9 7896.0 7919.8 7923.0 7929.0 7716.4 7844.8 7845.5 7846.5 7847.2 7782.8 7890.3 7896.6 8085.3 8089.4 7948.0 8013.9 8016.3 8023.2 8023.2 7895.9 8030.2 8034.4 8034.9 8037.8 38535.0 39082.4 39094.0 39128.0 39130.6 3004.4 3069.3 3437.9 3803.8 3845.8 29207.4 29352.1 29396.6 29427.7 29698.9 3128.8 3129.7 3172.5 3222.1 3245.0 239885.0 240225.0 240438.0 240602.8 241596.0 41003.8 42051.2 42138.8 54570.2 55827.0 39860.6 39996.8 40030.0 40117.4 40152.2 13097.3 13233.9 13260.2 13260.4 13271.1 10310.7 10351.4 10359.6 10369.9 10372.8 14590.7 14629.6 14669.7 14718.8 14945.0 5688.6 5804.9 5837.2 5860.7 5921.3 865.9 907.9 930.8 943.6 996.2 27164.6 27675.7 27681.3 27940.4 28082.6 780.8 972.6 987.8 995.9 998.6 12505.7 12629.0 12773.9 12782.6 12917.4 269162.0 273240.0 274023.0 274283.0 274774.0 41626.8 41632.6 41656.8 42600.6 42717.8 1035.2 1131.0 1219.0 1232.9 1239.1 24277.4 24534.4 25515.2 25534.5 25559.6 34610.7 34961.8 34986.5 34990.1 35005.8 162939.0 163595.0 163945.0 164141.0 316626.0 31157.0 31733.8 31739.8 32107.7 32142.4 34768.1 35984.5 36213.5 38301.2 38692.8 32716.0 33297.7 33934.5 34112.8 34195.3 33317.0 33365.0 33402.3 33519.3 33725.0 32568.3 32768.3 32771.7 33085.8 33089.7 29709.0 33784.8 34719.8 34874.1 36845.4 24605.9 24896.5 25119.0 25284.0 25326.0 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#2] jquery.html Cycles:180 Average:23155.20 Median:386958.00 stddev:63241.72 (16.3%) stddev-sans-first:63395.93 04:33:59 INFO - PROCESS | 4032 | Values: 343.5 346.3 351.9 357.7 361.8 14793.1 15275.6 15791.5 15846.5 15853.9 15185.2 15273.0 15515.8 15700.8 15746.7 4411.7 4546.5 4559.0 4563.4 4577.3 4390.9 4450.5 4513.9 4555.0 4555.8 4474.3 4529.5 4538.9 4541.5 4542.2 4584.3 4589.2 4604.1 5068.5 5080.0 4301.0 4392.0 4414.4 4424.2 4424.8 18793.7 19255.7 19659.3 19663.3 19690.4 1890.8 1908.0 1948.6 2116.3 2377.0 8551.8 8673.5 8722.7 8728.2 8908.2 1779.1 1803.8 1860.4 1877.5 1913.4 50177.0 58964.7 60826.4 63114.0 63116.0 9202.1 9448.1 9574.3 10051.9 10079.7 12494.1 12499.4 12555.7 12579.1 12585.6 7031.4 7150.9 7188.5 7276.6 7446.3 6914.2 6944.8 7039.0 7050.1 7184.1 4123.6 4187.6 4308.0 4350.9 4378.2 1731.4 1762.8 1776.6 1798.3 1856.0 819.5 862.9 884.3 890.7 898.0 15977.3 16128.7 16275.3 16401.2 16519.2 826.5 828.3 852.5 864.0 903.6 8984.3 9174.9 9386.8 9452.7 9616.2 375615.0 380947.4 383579.0 390337.0 398030.0 62744.7 63907.7 65224.0 66669.0 70458.6 941.5 950.2 958.4 987.2 991.5 14872.5 15415.8 15463.3 15495.9 15769.3 26496.3 27450.6 30970.2 35013.1 35335.2 42051.6 43869.3 44459.6 45793.3 46909.0 7123.0 7384.0 9860.7 10141.8 10192.2 11429.3 11542.5 11850.6 11952.2 12390.6 9987.5 10507.3 10718.9 10797.4 11281.4 10318.2 10677.2 10825.8 10913.6 11117.7 10333.7 10929.5 11021.7 11095.0 11160.6 10723.5 10815.5 10880.2 10930.6 11032.4 10767.1 10853.8 10856.2 10945.6 11059.9 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#3] mootools.html Cycles:180 Average:5215.57 Median:6183.08 stddev:2748.35 (44.4%) stddev-sans-first:2739.85 04:33:59 INFO - PROCESS | 4032 | Values: 1244.2 1389.2 1403.2 1517.9 1707.1 7311.0 7473.1 7489.7 7492.1 7496.2 7349.5 7547.2 7551.8 7553.0 7562.2 1915.9 2144.2 2208.2 2224.3 2254.2 2216.4 2224.6 2228.4 2229.7 2230.5 2060.2 2150.5 2154.3 2154.7 2155.0 2146.7 2151.4 2165.9 2222.7 2224.3 2185.8 2186.3 2193.0 2203.4 2203.6 7665.9 7708.2 7732.7 7745.3 7750.9 4584.0 4712.2 4717.4 4718.4 4718.6 2938.4 3072.6 3090.9 3147.3 3160.6 942.9 946.7 960.4 979.8 996.6 10290.5 10383.8 10384.8 10414.7 10415.5 3958.8 4086.2 4134.0 4172.2 4177.1 8196.1 8343.6 8403.8 8404.2 8405.3 3995.6 4642.0 4648.0 4668.6 4672.1 4103.1 4120.1 4161.7 4178.8 4214.6 3260.1 3344.1 3355.7 3366.2 3383.8 1025.0 1045.1 1046.9 1054.8 1055.3 999.4 1019.5 1023.0 1077.8 1188.8 7231.5 7261.4 7262.6 7274.8 7288.4 429.6 435.2 435.5 435.8 435.9 5661.3 5674.7 5734.1 5738.9 5749.1 8854.7 9064.8 9087.8 9103.4 9105.8 8762.6 8914.5 8931.3 8938.2 8977.9 6989.1 7058.0 7063.2 7101.5 7117.3 6856.2 6859.4 6909.4 6958.3 6964.6 7977.9 8001.5 8124.4 8219.3 8225.3 8327.6 8424.4 8617.6 8641.4 8641.4 5485.2 5631.9 5635.0 6276.6 6403.6 7060.8 7250.4 7259.9 7261.0 7261.6 6427.2 6555.6 6581.0 6662.7 6750.1 5864.4 6515.7 6543.6 6571.5 6595.0 6501.5 6503.5 6564.0 6566.9 6578.4 6117.2 6151.9 6231.7 6236.3 6244.4 6173.7 6192.5 6211.8 6217.6 6220.0 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#4] prototype.html Cycles:180 Average:4636.20 Median:5345.41 stddev:1372.87 (25.7%) stddev-sans-first:1337.76 04:33:59 INFO - PROCESS | 4032 | Values: 309.1 309.4 310.4 310.6 315.0 5227.0 5329.8 5337.1 5337.9 5352.9 5291.2 5324.9 5355.5 5355.7 5359.1 3910.6 3980.2 4064.5 4134.1 4134.3 4070.1 4080.1 4084.4 4086.9 4091.3 4031.4 4039.5 4041.6 4045.9 4054.3 3895.0 3955.6 4055.6 4068.1 4086.2 3556.0 3561.2 3566.2 3573.4 3573.7 5111.7 5127.4 5149.8 5151.1 5162.5 4713.9 4721.1 4722.7 4725.4 4725.5 5644.1 5646.3 5648.7 5650.3 5653.9 3921.4 3925.4 3925.5 3931.5 3931.7 5691.2 5824.2 5824.7 5833.5 5843.4 3946.5 3953.9 3968.2 3972.5 3978.5 4034.0 4034.2 4034.2 4037.6 4040.5 4659.3 4662.7 4666.8 4670.5 4676.0 5639.3 5646.5 5648.9 5653.0 5661.1 1391.7 1423.0 1425.2 1425.5 1426.9 909.4 949.8 953.9 970.2 973.1 4891.6 4899.9 4911.2 4915.0 4920.7 5830.5 5833.3 5842.5 5845.2 5847.2 4908.4 4914.8 4916.5 4918.4 4919.9 3091.2 3131.7 3132.3 3135.7 3136.1 5398.1 5412.4 5422.6 5425.6 5436.6 5762.3 5923.9 5961.1 5962.0 5969.9 5378.1 5399.4 5412.9 5418.7 5431.6 5812.4 5821.7 5825.8 5827.9 5831.9 5710.3 5713.1 5715.9 5723.4 5727.2 5409.1 5417.8 5424.3 5427.1 5428.5 3893.1 4005.7 4014.3 4014.8 4021.2 5600.1 5764.9 5773.5 5780.3 5791.0 5508.2 5606.0 5629.2 5639.8 5686.1 5623.5 5624.8 5628.2 5628.8 5667.9 5540.5 5543.9 5545.9 5549.1 5549.2 5701.1 5701.6 5703.6 5703.8 5704.4 5389.1 5549.3 5582.5 5585.1 5586.2 04:33:59 INFO - PROCESS | 4032 | 04:33:59 INFO - PROCESS | 4032 | [#5] yui.html Cycles:180 Average:13017.41 Median:44324.39 stddev:14862.74 (33.5%) stddev-sans-first:14875.57 04:33:59 INFO - PROCESS | 4032 | Values: 682.6 747.9 770.1 777.7 793.4 12365.6 12481.1 12534.6 12567.2 12601.6 11938.6 11988.3 12001.4 12009.3 12027.9 635.2 783.5 799.6 800.8 801.6 778.4 781.6 785.2 787.5 787.9 829.7 832.3 836.6 839.0 839.2 833.6 835.3 835.5 837.4 837.9 612.8 618.1 618.1 618.4 618.9 12546.1 12551.6 12573.2 12585.6 12595.7 12485.9 12698.9 12748.9 12757.4 12916.3 9350.6 9449.3 9530.1 9899.5 9951.3 2825.8 2884.8 2890.7 2898.8 2956.3 43837.6 45715.5 45734.3 45741.8 45778.0 9735.2 9870.9 10126.9 10275.8 10398.8 17695.9 17733.0 17829.4 17842.1 17863.6 6693.4 6738.0 6814.8 6829.9 7023.2 3767.5 3824.3 3883.2 3922.0 4036.5 2954.6 2999.0 3001.7 3003.1 3018.3 528.7 531.5 537.5 538.5 544.7 537.5 600.8 605.3 610.4 620.4 7281.3 7601.5 7640.0 7644.8 7700.8 509.9 591.3 608.1 616.8 625.5 3592.4 3631.3 3641.9 3664.5 3670.3 53083.2 53683.5 54995.5 55193.4 55221.2 43275.8 45191.5 47611.5 48181.5 51242.5 43432.0 43572.6 44224.0 44229.8 44419.0 8178.1 8209.4 8430.8 8438.0 8627.2 31143.1 31525.8 31618.4 32346.5 32417.8 38490.8 38687.4 41355.6 41393.0 41889.0 9907.7 10094.8 10517.2 10687.6 11153.4 12286.8 12512.6 12517.9 12539.7 13007.6 10898.4 11257.5 11383.0 11716.8 11993.8 10968.7 11130.6 11151.6 11186.6 11194.3 10272.7 10467.6 10812.9 10830.8 10842.8 9560.2 9736.4 9854.4 10358.8 10544.7 8777.0 9126.5 9617.2 9976.0 10009.4 04:33:59 INFO - PROCESS | 4032 | -------- Summary: end -------- 04:33:59 INFO - PROCESS | 4032 | 04:34:00 INFO - TEST-INFO | 4032: exit 0 04:34:00 INFO - TEST-OK | dromaeo_css | took 1116427ms 04:34:00 INFO - TEST-START | kraken 04:34:00 INFO - operating with platform_type : linux_ 04:34:00 INFO - Initialising browser for kraken test... 04:34:00 INFO - TEST-INFO | started process 4214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNc7kiB/profile http://localhost:46026/getInfo.html) 04:34:04 INFO - PROCESS | 4214 | __metrics Screen width/height:1600/1200 04:34:04 INFO - PROCESS | 4214 | colorDepth:24 04:34:04 INFO - PROCESS | 4214 | Browser inner width/height: 1024/697 04:34:04 INFO - PROCESS | 4214 | __metrics 04:34:05 ERROR - PROCESS | 4214 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:34:05 INFO - PROCESS | 4214 | JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 04:34:06 INFO - TEST-INFO | 4214: exit 0 04:34:06 INFO - Browser initialized. 04:34:06 INFO - Running cycle 1/1 for kraken test... 04:34:06 INFO - TEST-INFO | started process 4298 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNc7kiB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:34:18 INFO - PROCESS | 4298 | RSS: Main: 157675520 04:34:18 INFO - PROCESS | 4298 | 04:34:21 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-beat-detection) 04:34:21 INFO - PROCESS | 4298 | RSS: Main: 200368128 04:34:21 INFO - PROCESS | 4298 | 04:34:24 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-dft) 04:34:25 INFO - PROCESS | 4298 | RSS: Main: 188043264 04:34:25 INFO - PROCESS | 4298 | 04:34:28 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-fft) 04:34:28 INFO - PROCESS | 4298 | RSS: Main: 172138496 04:34:28 INFO - PROCESS | 4298 | 04:34:30 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46026/tests/kraken/driver.html?testName=audio-oscillator) 04:34:31 INFO - PROCESS | 4298 | RSS: Main: 174465024 04:34:31 INFO - PROCESS | 4298 | 04:34:33 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:34:34 INFO - PROCESS | 4298 | RSS: Main: 175878144 04:34:34 INFO - PROCESS | 4298 | 04:34:37 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-darkroom) 04:34:38 INFO - PROCESS | 4298 | RSS: Main: 175726592 04:34:38 INFO - PROCESS | 4298 | 04:34:41 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46026/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:42 INFO - PROCESS | 4298 | RSS: Main: 178388992 04:34:42 INFO - PROCESS | 4298 | 04:34:44 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46026/tests/kraken/driver.html?testName=json-parse-financial) 04:34:45 INFO - PROCESS | 4298 | RSS: Main: 177758208 04:34:45 INFO - PROCESS | 4298 | 04:34:47 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46026/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:47 INFO - PROCESS | 4298 | RSS: Main: 188940288 04:34:47 INFO - PROCESS | 4298 | 04:34:49 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:50 INFO - PROCESS | 4298 | RSS: Main: 185319424 04:34:50 INFO - PROCESS | 4298 | 04:34:52 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:52 INFO - PROCESS | 4298 | RSS: Main: 197308416 04:34:52 INFO - PROCESS | 4298 | 04:34:55 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:56 INFO - PROCESS | 4298 | RSS: Main: 200417280 04:34:56 INFO - PROCESS | 4298 | 04:34:58 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:59 INFO - PROCESS | 4298 | RSS: Main: 199278592 04:34:59 INFO - PROCESS | 4298 | 04:35:00 INFO - PROCESS | 4298 | Cycle 1(1): loaded http://localhost:46026/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46026/tests/kraken/driver.html?testName=ai-astar) 04:35:01 INFO - PROCESS | 4298 | RSS: Main: 259452928 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | __start_tp_report 04:35:01 INFO - PROCESS | 4298 | _x_x_mozilla_page_load 04:35:01 INFO - PROCESS | 4298 | _x_x_mozilla_page_load_details 04:35:01 INFO - PROCESS | 4298 | |i|pagename|runs| 04:35:01 INFO - PROCESS | 4298 | |0;ai-astar;110;114;106;111;112;112;101;112;112;111 04:35:01 INFO - PROCESS | 4298 | |1;audio-beat-detection;158;130;151;170;131;157;154;138;172;131 04:35:01 INFO - PROCESS | 4298 | |2;audio-dft;161;164;162;160;163;161;163;163;163;160 04:35:01 INFO - PROCESS | 4298 | |3;audio-fft;74;73;102;96;73;75;73;119;93;72 04:35:01 INFO - PROCESS | 4298 | |4;audio-oscillator;94;95;142;94;95;94;141;93;94;132 04:35:01 INFO - PROCESS | 4298 | |5;imaging-gaussian-blur;118;117;117;117;117;117;117;117;117;116 04:35:01 INFO - PROCESS | 4298 | |6;imaging-darkroom;146;146;146;146;146;146;146;145;147;145 04:35:01 INFO - PROCESS | 4298 | |7;imaging-desaturate;95;95;96;96;95;95;96;95;96;95 04:35:01 INFO - PROCESS | 4298 | |8;json-parse-financial;65;66;64;65;65;65;65;75;64;64 04:35:01 INFO - PROCESS | 4298 | |9;json-stringify-tinderbox;63;65;63;65;64;65;65;64;65;65 04:35:01 INFO - PROCESS | 4298 | |10;stanford-crypto-aes;82;80;80;81;81;80;80;80;81;81 04:35:01 INFO - PROCESS | 4298 | |11;stanford-crypto-ccm;114;115;122;114;128;119;117;118;115;117 04:35:01 INFO - PROCESS | 4298 | |12;stanford-crypto-pbkdf2;140;140;146;140;140;130;146;141;137;142 04:35:01 INFO - PROCESS | 4298 | |13;stanford-crypto-sha256-iterative;67;70;66;65;66;67;66;65;67;66 04:35:01 INFO - PROCESS | 4298 | __end_tp_report 04:35:01 INFO - PROCESS | 4298 | __start_cc_report 04:35:01 INFO - PROCESS | 4298 | _x_x_mozilla_cycle_collect,1139 04:35:01 INFO - PROCESS | 4298 | __end_cc_report 04:35:01 INFO - PROCESS | 4298 | __startTimestamp1458732901124__endTimestamp 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | ------- Summary: start ------- 04:35:01 INFO - PROCESS | 4298 | Number of tests: 14 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#0] ai-astar Cycles:10 Average:110.10 Median:112.00 stddev:3.81 (3.4%) stddev-sans-first:4.04 04:35:01 INFO - PROCESS | 4298 | Values: 110.0 114.0 106.0 111.0 112.0 112.0 101.0 112.0 112.0 111.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#1] audio-beat-detection Cycles:10 Average:149.20 Median:155.50 stddev:15.89 (10.2%) stddev-sans-first:16.54 04:35:01 INFO - PROCESS | 4298 | Values: 158.0 130.0 151.0 170.0 131.0 157.0 154.0 138.0 172.0 131.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#2] audio-dft Cycles:10 Average:162.00 Median:163.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 04:35:01 INFO - PROCESS | 4298 | Values: 161.0 164.0 162.0 160.0 163.0 161.0 163.0 163.0 163.0 160.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#3] audio-fft Cycles:10 Average:85.00 Median:73.50 stddev:16.51 (22.5%) stddev-sans-first:17.02 04:35:01 INFO - PROCESS | 4298 | Values: 74.0 73.0 102.0 96.0 73.0 75.0 73.0 119.0 93.0 72.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#4] audio-oscillator Cycles:10 Average:107.40 Median:94.00 stddev:21.51 (22.9%) stddev-sans-first:22.26 04:35:01 INFO - PROCESS | 4298 | Values: 94.0 95.0 142.0 94.0 95.0 94.0 141.0 93.0 94.0 132.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 04:35:01 INFO - PROCESS | 4298 | Values: 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 04:35:01 INFO - PROCESS | 4298 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 145.0 147.0 145.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:35:01 INFO - PROCESS | 4298 | Values: 95.0 95.0 96.0 96.0 95.0 95.0 96.0 95.0 96.0 95.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:65.00 stddev:3.29 (5.1%) stddev-sans-first:3.48 04:35:01 INFO - PROCESS | 4298 | Values: 65.0 66.0 64.0 65.0 65.0 65.0 65.0 75.0 64.0 64.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#9] json-stringify-tinderbox Cycles:10 Average:64.40 Median:65.00 stddev:0.84 (1.3%) stddev-sans-first:0.73 04:35:01 INFO - PROCESS | 4298 | Values: 63.0 65.0 63.0 65.0 64.0 65.0 65.0 64.0 65.0 65.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#10] stanford-crypto-aes Cycles:10 Average:80.60 Median:81.00 stddev:0.70 (0.9%) stddev-sans-first:0.53 04:35:01 INFO - PROCESS | 4298 | Values: 82.0 80.0 80.0 81.0 81.0 80.0 80.0 80.0 81.0 81.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#11] stanford-crypto-ccm Cycles:10 Average:117.90 Median:117.50 stddev:4.33 (3.7%) stddev-sans-first:4.36 04:35:01 INFO - PROCESS | 4298 | Values: 114.0 115.0 122.0 114.0 128.0 119.0 117.0 118.0 115.0 117.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.20 Median:140.50 stddev:4.54 (3.2%) stddev-sans-first:4.82 04:35:01 INFO - PROCESS | 4298 | Values: 140.0 140.0 146.0 140.0 140.0 130.0 146.0 141.0 137.0 142.0 04:35:01 INFO - PROCESS | 4298 | 04:35:01 INFO - PROCESS | 4298 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.50 stddev:1.43 (2.2%) stddev-sans-first:1.51 04:35:01 INFO - PROCESS | 4298 | Values: 67.0 70.0 66.0 65.0 66.0 67.0 66.0 65.0 67.0 66.0 04:35:01 INFO - PROCESS | 4298 | -------- Summary: end -------- 04:35:01 INFO - PROCESS | 4298 | 04:35:02 INFO - TEST-INFO | 4298: exit 0 04:35:02 INFO - TEST-OK | kraken | took 61582ms 04:35:02 INFO - SUITE-END | took 1178s 04:35:02 INFO - Completed test suite (00:19:38) 04:35:02 INFO - javascript benchmark 04:35:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2608.7260837612052, 2671.185288487013, 2674.8436844523453, 2685.154176434422, 2710.76958458531, 4531.63746900248, 4612.285095810146, 4661.4639316478615, 4666.603338716209, 4691.202495575756, 4704.6706730528795, 4706.741129237899, 4735.242361222206, 4755.690880092791, 4794.208955522335, 4226.535081141072, 4318.417013703149, 4378.8686339409705, 4400.559944005606, 4419.712718673276, 4368.803403846835, 4398.340248962665, 4418.447694038246, 4420.580044895746, 4462.375267462541, 4238.08881090564, 4253.63844073251, 4326.264535029021, 4354.629856462205, 4367.410399596046, 4330.653547716175, 4340.804663790137, 4348.695591308609, 4385.802638881258, 4406.383106365111, 4185.811638476245, 4335.024619460628, 4341.131773645284, 4343.891402714926, 4384.123175364908, 4576.725396476222, 4607.631389488833, 4669.579737823578, 4712.293156026623, 4716.882077948045, 5037.571806396424, 5064.848054558369, 5071.670341427795, 5116.079105760999, 5120.334356533627, 4934.0, 5084.262781896641, 5104.259882317043, 5106.361704786902, 5107.438181799999, 4717.410323709536, 4745.383100196952, 4765.475797662254, 4799.496052914464, 4804.0, 5227.3465816772905, 5245.0558899398475, 5248.790048398021, 5250.238715386247, 5259.132243179909, 4821.132196204717, 4963.801447942042, 5033.697978121324, 5033.949660503348, 5069.036882992294, 4952.232403977389, 4981.875453113701, 4983.526564976321, 5027.1956486962645, 5031.396232452129, 4962.826301079517, 4966.701997880139, 4972.57733092684, 4974.253861920741, 5018.648694591344, 4877.0, 4975.0547395994645, 5013.097642424399, 5021.472745361684, 5063.797448102035, 4246.596573325529, 4254.276772948606, 4265.0616864289805, 4277.123189746157, 4280.657547396201, 3724.0875985383755, 3745.3445647011663, 3746.756460830037, 3769.86805461813, 3789.7157713171073, 4257.510386305615, 4326.848560300375, 4343.3484977253665, 4345.304751239786, 4417.646588272994, 5033.219850923113, 5069.290299358093, 5070.898582028339, 5075.619328550373, 5112.0, 4335.132973405269, 4337.0892112656065, 4339.088791353788, 4383.101464199832, 4383.9342409863875, 4478.1715382653665, 4530.97734511332, 4558.133954548625, 4579.084183163381, 4609.331646911179, 4691.366665500251, 4702.553257440538, 4704.482506924167, 4711.458182309078, 4754.286856971482, 4978.153713868579, 5006.123928312458, 5019.974900125476, 5020.322256495327, 5068.138416469135, 4663.417072865892, 4764.190087685032, 4794.2808578713475, 4809.951900480951, 4847.684900481458, 4992.850214493571, 5005.074061298671, 5024.472430394756, 5027.27104569828, 5081.5426611605135, 4832.806687732451, 5070.797168113234, 5088.9567638634735, 5103.821366252312, 5119.308893299357, 4894.755262236803, 4934.753262336797, 4959.057779021974, 4987.0, 5003.1744762115295, 4886.53577910098, 4928.457869634266, 4928.901421971612, 4929.359183306147, 4970.7514624267915, 4666.743329116931, 4808.663393562417, 4842.346283251716, 4845.418549773909, 4902.264660300983, 4945.282933974481, 4960.70235785854, 4982.078315511642, 5013.623978201576, 5016.046951079284, 4841.8547443576745, 4844.733539655353, 4847.927281090716, 4860.1008813369635, 4865.56209941107], "unit": "score", "name": "dojo.html", "value": 4636.307932762433}, {"lowerIsBetter": false, "replicates": [502.14133831148735, 522.5636593444474, 527.0723526593194, 536.1047051424122, 549.7059073395734, 27089.864550677245, 27585.862070689644, 27586.17241482756, 34363.140921476974, 34708.65291347092, 37936.43095353572, 38449.0, 38462.80768596153, 38492.0, 38544.22911541768, 7740.8838867417035, 7895.960520197391, 7919.8416031679335, 7923.049234091917, 7928.9603551982445, 7716.382689384864, 7844.764657060269, 7845.529268243895, 7846.4899781514305, 7847.176046515119, 7782.805429864242, 7890.3293220076075, 7896.644650990719, 8085.312748416362, 8089.393295502831, 7948.0, 8013.879791803157, 8016.318612917909, 8023.157568455286, 8023.237792409741, 7895.881561776578, 8030.23712747288, 8034.357251419872, 8034.919650803476, 8037.758867233933, 38535.0, 39082.41376379328, 39094.0, 39128.0, 39130.60869391298, 3004.3690824926794, 3069.294062365668, 3437.8796742113905, 3803.7527560708463, 3845.8461661533506, 29207.415851682847, 29352.119436416942, 29396.559051614244, 29427.705722942712, 29698.85150574255, 3128.8279144647036, 3129.6557378688326, 3172.460681684096, 3222.081706713599, 3245.042712399848, 239885.0, 240225.0, 240438.0, 240602.7969860157, 241596.0, 41003.7949810255, 42051.15897682029, 42138.78930605327, 54570.18144727832, 55827.0, 39860.601393985686, 39996.80001599973, 40030.0, 40117.398239026435, 40152.19695606072, 13097.279649619171, 13233.867661323264, 13260.204387736767, 13260.40328185234, 13271.137376070525, 10310.690679279634, 10351.378917264989, 10359.585616575403, 10369.896301037044, 10372.844407333896, 14590.708185836223, 14629.561113166623, 14669.706605867823, 14718.779218311734, 14945.0, 5688.63023903445, 5804.883902322014, 5837.211976383219, 5860.736266868002, 5921.289445266596, 865.904750477447, 907.8774365460711, 930.8417569013284, 943.6036864516919, 996.2080146283722, 27164.592531112048, 27675.723242767315, 27681.307967300574, 27940.44119117606, 28082.578761318597, 780.8438312337555, 972.5866506734609, 987.782687808681, 995.8854731705802, 998.6354980432089, 12505.687357816127, 12629.0, 12773.872261277269, 12782.552610658582, 12917.354132293536, 269162.0, 273240.0, 274023.0, 274283.0, 274774.0, 41626.791866040476, 41632.58367416348, 41656.791716041225, 42600.57399425966, 42717.78641106775, 1035.2028937718067, 1130.9660710178707, 1219.0186899545774, 1232.8520577530753, 1239.0954603139578, 24277.393065172804, 24534.386640334134, 25515.234542963743, 25534.48931021332, 25559.616605750558, 34610.653893460745, 34961.82519087388, 34986.475202871465, 34990.12524686903, 35005.82497087498, 162939.0, 163595.0, 163945.0, 164141.0, 316626.0, 31157.0, 31733.8413307932, 31739.84130079335, 32107.678923210467, 32142.357152856344, 34768.130796730286, 35984.460233097045, 36213.45679814752, 38301.233975320894, 38692.80653596714, 32716.0, 33297.66702332946, 33934.481054612195, 34112.82943585266, 34195.316093678484, 33317.0, 33365.0, 33402.33195336128, 33519.32961340808, 33725.0, 32568.34863302768, 32768.344633106724, 32771.67228327782, 33085.83457082699, 33089.66910330866, 29708.960186394237, 33784.831075844464, 34719.82640086783, 34874.12814679653, 36845.44731828971, 24605.87697061503, 24896.50206995886, 25119.0, 25284.0, 25326.0], "unit": "score", "name": "ext.html", "value": 16183.94493282626}, {"lowerIsBetter": false, "replicates": [343.5053522926985, 346.31602584894836, 351.9243362677024, 357.7334885510295, 361.81004972389474, 14793.112413255212, 15275.618109547253, 15791.526254212393, 15846.524604261862, 15853.920730396361, 15185.240737963086, 15273.0, 15515.767263491029, 15700.842991570082, 15746.685066298667, 4411.713238639494, 4546.454425468948, 4558.954410455903, 4563.361129441881, 4577.290519969393, 4390.912181756363, 4450.5104438511735, 4513.864584062483, 4554.975130595622, 4555.817767289304, 4474.3064824952025, 4529.524399938008, 4538.931916021263, 4541.523140070278, 4542.205114105019, 4584.335271385664, 4589.24277494213, 4604.1482325769675, 5068.543831055223, 5080.034793389244, 4300.978495107535, 4392.0, 4414.404055452537, 4424.159409712144, 4424.756638384888, 18793.718094228596, 19255.711164332548, 19659.311924082587, 19663.311784087487, 19690.40928772139, 1890.8392786613153, 1908.0459770114942, 1948.6492431362349, 2116.343933380657, 2376.988115059431, 8551.82896342076, 8673.479591224546, 8722.651093956234, 8728.214460698568, 8908.198262156437, 1779.0837718574944, 1803.765510483642, 1860.38607259604, 1877.4836919847014, 1913.3685883658359, 50177.0, 58964.70517647384, 60826.39173608296, 63114.0, 63116.0, 9202.125798049176, 9448.149666530046, 9574.281928855364, 10051.949740251252, 10079.748006299902, 12494.125411221308, 12499.3750312484, 12555.748885022249, 12579.119461637598, 12585.622431327074, 7031.437485001187, 7150.892736608955, 7188.4968052235845, 7276.63616819157, 7446.292602202782, 6914.239433662293, 6944.756933507303, 7038.964805175941, 7050.083489146481, 7184.066071410683, 4123.628873401348, 4187.581241875788, 4308.030693094029, 4350.912981740411, 4378.233809083397, 1731.437282883068, 1762.7796525434321, 1776.640869734654, 1798.2627122879558, 1856.0441372693074, 819.5410570080774, 862.8878245828128, 884.2572239319003, 890.701614958996, 898.0, 15977.281022354022, 16128.677426451406, 16275.348986040663, 16401.1799410029, 16519.174041297887, 826.4793180296375, 828.2918105020242, 852.4672079950032, 864.0365991919091, 903.584351198443, 8984.32617553686, 9174.908250917539, 9386.765330866783, 9452.669156579486, 9616.23070154386, 375615.0, 380947.4289428304, 383579.0, 390337.0, 398030.0, 62744.686276568325, 63907.68046159833, 65224.0, 66669.0, 70458.64770676114, 941.5339406993583, 950.1733491862125, 958.3579002068631, 987.2496902354262, 991.4794732765356, 14872.479463218735, 15415.768763468333, 15463.304151312994, 15495.922520387327, 15769.29038193307, 26496.337591559593, 27450.588241176, 30970.23640908658, 35013.12467188341, 35335.17318614453, 42051.57948420599, 43869.34195986999, 44459.55540444684, 45793.313100304185, 46909.0, 7122.964385178041, 7384.0, 9860.704178874645, 10141.84787228207, 10192.235582331206, 11429.257098288585, 11542.480588373375, 11850.644480665595, 11952.223105498115, 12390.5663301784, 9987.500624968869, 10507.31702439339, 10718.946405267923, 10797.352158870493, 11281.379524126252, 10318.17454603645, 10677.199210059121, 10825.837612435662, 10913.563457461612, 11117.666470005914, 10333.689989300334, 10929.508172132431, 11021.724456888322, 11095.0, 11160.609378672032, 10723.517441714985, 10815.459227038775, 10880.161409536506, 10930.617428389969, 11032.393218373067, 10767.138628909825, 10853.78292434131, 10856.240063195817, 10945.616903408343, 11059.944700276446], "unit": "score", "name": "jquery.html", "value": 7960.70046227959}, {"lowerIsBetter": false, "replicates": [1244.1850587864951, 1389.16650009994, 1403.151093588379, 1517.946871859485, 1707.0525858148721, 7311.0, 7473.103227612681, 7489.662965166567, 7492.063492063492, 7496.175420703725, 7349.485536012481, 7547.16981132075, 7551.773446796591, 7552.96223518883, 7562.205968373324, 1915.9042047897549, 2144.15305954148, 2208.1719355241785, 2224.254874617005, 2254.211026140854, 2216.357256395643, 2224.555088982202, 2228.4206106412366, 2229.7435794883636, 2230.475838178027, 2060.1759296281457, 2150.5268840855065, 2154.310620601408, 2154.666026765854, 2155.008695999842, 2146.6565349544, 2151.354593621915, 2165.852098387857, 2222.744384395799, 2224.288227767115, 2185.825133989277, 2186.256672731279, 2193.0350645715835, 2203.4271089516683, 2203.603351396748, 7665.8850117248285, 7708.229177082303, 7732.6906923723545, 7745.264199901, 7750.922490775133, 4584.0, 4712.198926182557, 4717.410323709536, 4718.386609740712, 4718.575328220442, 2938.353562216309, 3072.554479600468, 3090.90727278182, 3147.291859331655, 3160.6365267994247, 942.9292803039731, 946.7159852044427, 960.351762560269, 979.7893452907659, 996.5913975270176, 10290.485475726258, 10383.792324153475, 10384.792304153874, 10414.687559373231, 10415.531301091394, 3958.762474251554, 4086.244044851712, 4134.0, 4172.207280616733, 4177.143685544517, 8196.13940536247, 8343.624536895853, 8403.789905252417, 8404.159584041668, 8405.285550728135, 3995.6004399560393, 4642.0, 4648.047150334173, 4668.5798278155125, 4672.065586882569, 4103.076807718239, 4120.052387950788, 4161.667066634662, 4178.811953462041, 4214.557471465452, 3260.0871755908383, 3344.080377896098, 3355.7147642450177, 3366.225768073357, 3383.8308084595674, 1024.9897501025043, 1045.0803293102174, 1046.9162467002623, 1054.8206804843196, 1055.2718624149313, 999.4453078541334, 1019.5259204469809, 1023.0281232828694, 1077.7952189084049, 1188.7622475504934, 7231.529950553302, 7261.3827824634445, 7262.564246145248, 7274.781756547312, 7288.416926645856, 429.63266407221374, 435.17317097514973, 435.507876100005, 435.7690424075245, 435.8975640724427, 5661.2923384576925, 5674.744636491368, 5734.111212762028, 5738.942610573924, 5749.137629355547, 8854.690085847093, 9064.818703626022, 9087.81824363509, 9103.408278462011, 9105.81788364229, 8762.561871906379, 8914.509701966324, 8931.285497160212, 8938.195562399414, 8977.910220897838, 6989.0564773755905, 7058.011878337037, 7063.187733410621, 7101.502894797314, 7117.288271172842, 6856.24581296067, 6859.382655560824, 6909.412699920563, 6958.269381714847, 6964.582125072512, 7977.880331794911, 8001.519908805491, 8124.431289809657, 8219.301359384519, 8225.300849427866, 8327.625256863335, 8424.410291279797, 8617.569121544024, 8641.351898607503, 8641.395102342776, 5485.177223416519, 5631.8592035199445, 5635.042042852643, 6276.623402595859, 6403.583767055126, 7060.823479413056, 7250.419966402781, 7259.891101633374, 7261.0, 7261.564306141649, 6427.228732551936, 6555.639439830855, 6581.0, 6662.733490660513, 6750.05499230118, 5864.413558644102, 6515.73937042513, 6543.640099794557, 6571.507136964842, 6595.0, 6501.4798816095545, 6503.51223658237, 6563.967180164069, 6566.9014964776525, 6578.407943285128, 6117.235345581802, 6151.907721384272, 6231.719572619334, 6236.34518375564, 6244.375562443719, 6173.6913154343, 6192.473639740672, 6211.782587609412, 6217.595856269328, 6219.968900155471], "unit": "score", "name": "mootools.html", "value": 4183.165935906399}, {"lowerIsBetter": false, "replicates": [309.11901081916534, 309.3951325159312, 310.3513656458005, 310.5698607428711, 314.9968500314998, 5226.96148502084, 5329.840104796853, 5337.14605663094, 5337.946620533793, 5352.866178345544, 5291.2327712481665, 5324.920126198101, 5355.464453554642, 5355.732213389334, 5359.115745901921, 3910.648041676249, 3980.2039592081555, 4064.4919385076864, 4134.13183231521, 4134.3178375567995, 4070.0638853063815, 4080.1431699343025, 4084.4485994390675, 4086.89782755432, 4091.3453847384426, 4031.415444760508, 4039.515258169009, 4041.575634558373, 4045.939310910339, 4054.2702313583545, 3895.0067732728116, 3955.564887862333, 4055.574164712707, 4068.145689405199, 4086.1827634473225, 3556.0220939241917, 3561.1631266652316, 3566.215432604849, 3573.4103872860946, 3573.6783689468075, 5111.744412779346, 5127.359080114986, 5149.841285710722, 5151.124308867502, 5162.5095615916425, 4713.858584242478, 4721.126591580569, 4722.7402492862875, 4725.432948046222, 4725.480197178307, 5644.096944488862, 5646.265985421869, 5648.661080335193, 5650.29371328584, 5653.886922261532, 3921.4117882317596, 3925.3719404895364, 3925.509311336083, 3931.4889064421727, 3931.6658084062888, 5691.231683722686, 5824.213731146326, 5824.650520968756, 5833.504152147073, 5843.415658434123, 3946.4869566956686, 3953.9011524711536, 3968.166684996183, 3972.5431575368625, 3978.5026871641044, 4033.979830100831, 4034.1528279061727, 4034.204778873373, 4037.6164264394833, 4040.4949381327333, 4659.347691323217, 4662.743549104832, 4666.789994450258, 4670.5329467053025, 4675.976620116878, 5639.295088113986, 5646.463585959327, 5648.85877853057, 5653.038983372837, 5661.122526008476, 1391.7146984868077, 1422.9786553201711, 1425.1805212002932, 1425.49394964786, 1426.9286535673175, 909.4497828813472, 949.7862980829258, 953.8521529162991, 970.1898914406408, 973.090160699748, 4891.584215341736, 4899.877503062381, 4911.214205727067, 4915.0415668944215, 4920.655554111249, 5830.504407125357, 5833.270841144857, 5842.532597392198, 5845.240118784616, 5847.152162936435, 4908.386451693538, 4914.8034078637165, 4916.483769204254, 4918.409790825052, 4919.901601968012, 3091.180837078176, 3131.7024882636115, 3132.3265497918055, 3135.6864313568462, 3136.106209730216, 5398.055340315429, 5412.350517937873, 5422.6475279106735, 5425.593080518976, 5436.646617969819, 5762.279715035621, 5923.851903702356, 5961.135635332853, 5962.046072628359, 5969.910451343233, 5378.085725426687, 5399.406065332811, 5412.864678383072, 5418.729063546728, 5431.565474762088, 5812.360640329645, 5821.738021789114, 5825.825225243249, 5827.9417205829095, 5831.854203644773, 5710.314762228393, 5713.143028545752, 5715.8571035724435, 5723.427657234243, 5727.226824378656, 5409.134538473825, 5417.783288668409, 5424.294841670558, 5427.077396842467, 5428.45715428454, 3893.0851249956804, 4005.69957253213, 4014.2573623879675, 4014.759114453142, 4021.215862906822, 5600.103983362643, 5764.913526297025, 5773.5092517134835, 5780.335261444988, 5790.971045144747, 5508.228847961209, 5606.0, 5629.211910332475, 5639.830805075854, 5686.090225564056, 5623.465770751772, 5624.775008999594, 5628.183913332626, 5628.831135065954, 5667.943320566907, 5540.501354877919, 5543.861403464945, 5545.889082218252, 5549.084401073777, 5549.1676248563035, 5701.116326969326, 5701.629394089371, 5703.600747947604, 5703.828885133453, 5704.429557044428, 5389.137737961907, 5549.250851135206, 5582.49757521825, 5585.134304182858, 5586.217929489793], "unit": "score", "name": "prototype.html", "value": 4195.444456512403}, {"lowerIsBetter": false, "replicates": [682.6382017530708, 747.8691229034918, 770.0528350129341, 777.7161336112321, 793.3573805217774, 12365.56720514781, 12481.126321157522, 12534.623961281177, 12567.183133096354, 12601.621951341464, 11938.641840744769, 11988.280703157794, 12001.399930003508, 12009.339486328248, 12027.879721202786, 635.2218532297921, 783.475071701961, 799.60019990005, 800.75977206838, 801.5671537369814, 778.3967425245423, 781.6482582837746, 785.1834092543747, 787.4527203593505, 787.9212078792132, 829.6764261937849, 832.342449464922, 836.5691668790578, 838.9580520973957, 839.1692224697535, 833.6207025803245, 835.2566216067704, 835.5488036460304, 837.4054421360811, 837.9120192379834, 612.8406614280319, 618.0698049435571, 618.0975775367968, 618.3877960818756, 618.9071639254103, 12546.121771476, 12551.560695375709, 12573.182743121759, 12585.559505417266, 12595.685107872285, 12485.93757031218, 12698.873011269861, 12748.872511274862, 12757.42591583381, 12916.297202641303, 9350.57922393494, 9449.291303152222, 9530.094641009093, 9899.505024748805, 9951.303408761389, 2825.7739380849484, 2884.754795842356, 2890.7253810887933, 2898.840563768992, 2956.3200463893427, 43837.56162438367, 45715.542844571464, 45734.31398529058, 45741.77129114366, 45778.0, 9735.221182305399, 9870.851937220947, 10126.898731012743, 10275.845862312071, 10398.792024159475, 17695.911520442573, 17733.024683642267, 17829.375971841182, 17842.107894605477, 17863.553411164823, 6693.364130407604, 6737.9663101685155, 6814.761483348059, 6829.931700683029, 7023.227444981048, 3767.453719210699, 3824.3116239076676, 3883.203943191639, 3921.9607803921594, 4036.495438070241, 2954.5863579098946, 2999.0, 3001.7448516875875, 3003.1441039303695, 3018.320877802477, 528.6933578524447, 531.4897698209685, 537.5377175628956, 538.488435985815, 544.7194694732216, 537.4867002013068, 600.8227572866015, 605.306923572507, 610.4322979628988, 620.4292051312804, 7281.308275713799, 7601.467897247139, 7640.0, 7644.847103057908, 7700.807479813049, 509.9490050994945, 591.2993103172754, 608.054475290918, 616.7902913009509, 625.5464788028734, 3592.3713350163616, 3631.2555926035097, 3641.927161456756, 3664.486971823947, 3670.2749707637367, 53083.20375194375, 53683.46316536863, 54995.450045499834, 55193.44806551883, 55221.17168242479, 43275.78362108232, 45191.548084518734, 47611.52388476071, 48181.5181848177, 51242.48757512377, 43432.0, 43572.564274357486, 44224.0, 44229.77885110618, 44419.0, 8178.1412951641605, 8209.425340226366, 8430.831383372175, 8437.95781021091, 8627.180417860292, 31143.065708028797, 31525.842370788, 31618.367632647678, 32346.514802278456, 32417.837910810296, 38490.80754596209, 38687.41968870413, 41355.58644413517, 41393.0, 41889.0, 9907.653232136841, 10094.798104038025, 10517.158627309644, 10687.625933092304, 11153.386563739072, 12286.815697764361, 12512.624621261377, 12517.874821251671, 12539.686507837378, 13007.609771706864, 10898.40058796742, 11257.49341279628, 11382.975532202141, 11716.765664686489, 11993.760124797629, 10968.725781855517, 11130.610428635282, 11151.609693660683, 11186.608468703556, 11194.272372295774, 10272.743181420225, 10467.581296748045, 10812.891871081503, 10830.783384332111, 10842.837357439803, 9560.187384072431, 9736.367136136128, 9854.408735475894, 10358.792824143626, 10544.736381590521, 8777.0, 9126.45241285525, 9617.23062155012, 9975.950120249352, 10009.449480278654], "unit": "score", "name": "yui.html", "value": 5978.909933413934}], "name": "dromaeo_css", "value": 6302.687418169742}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 114.0, 106.0, 111.0, 112.0, 112.0, 101.0, 112.0, 112.0, 111.0], "unit": "score", "name": "ai-astar", "value": 110.1}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 151.0, 170.0, 131.0, 157.0, 154.0, 138.0, 172.0, 131.0], "unit": "score", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [161.0, 164.0, 162.0, 160.0, 163.0, 161.0, 163.0, 163.0, 163.0, 160.0], "unit": "score", "name": "audio-dft", "value": 162.0}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 102.0, 96.0, 73.0, 75.0, 73.0, 119.0, 93.0, 72.0], "unit": "score", "name": "audio-fft", "value": 85.0}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 142.0, 94.0, 95.0, 94.0, 141.0, 93.0, 94.0, 132.0], "unit": "score", "name": "audio-oscillator", "value": 107.4}, {"lowerIsBetter": true, "replicates": [118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 117.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 145.0, 147.0, 145.0], "unit": "score", "name": "imaging-darkroom", "value": 145.9}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 96.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [65.0, 66.0, 64.0, 65.0, 65.0, 65.0, 65.0, 75.0, 64.0, 64.0], "unit": "score", "name": "json-parse-financial", "value": 65.8}, {"lowerIsBetter": true, "replicates": [63.0, 65.0, 63.0, 65.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 64.4}, {"lowerIsBetter": true, "replicates": [82.0, 80.0, 80.0, 81.0, 81.0, 80.0, 80.0, 80.0, 81.0, 81.0], "unit": "score", "name": "stanford-crypto-aes", "value": 80.6}, {"lowerIsBetter": true, "replicates": [114.0, 115.0, 122.0, 114.0, 128.0, 119.0, 117.0, 118.0, 115.0, 117.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 117.9}, {"lowerIsBetter": true, "replicates": [140.0, 140.0, 146.0, 140.0, 140.0, 130.0, 146.0, 141.0, 137.0, 142.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 140.2}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 66.0, 65.0, 66.0, 67.0, 66.0, 65.0, 67.0, 66.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1507.4}]} 04:35:02 INFO - Return code: 0 04:35:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:35:02 ERROR - # TBPL SUCCESS # 04:35:02 INFO - Running post-action listener: _resource_record_post_action 04:35:02 INFO - Running post-run listener: _resource_record_post_run 04:35:03 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 466944; Write bytes: 299225088; Read time: 116; Write time: 253700 04:35:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 17448960; Read time: 0; Write time: 10184 04:35:03 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 466944; Write bytes: 281776128; Read time: 116; Write time: 243516 04:35:03 INFO - Running post-run listener: _upload_blobber_files 04:35:03 INFO - Blob upload gear active. 04:35:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:35:03 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 04:35:03 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:35:03 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:35:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:35:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:35:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:35:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:04 INFO - (blobuploader) - INFO - Done attempting. 04:35:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:35:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:35:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:35:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:35:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:35:05 INFO - (blobuploader) - INFO - Done attempting. 04:35:05 INFO - (blobuploader) - INFO - Iteration through files over. 04:35:05 INFO - Return code: 0 04:35:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:35:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:35:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/456a03bd5c6186cc0a021d83be84f11903f846d66627b05327d9a1af9e7096b84acdb276336d56bdb6f5420390fdef39bb2c57b2eeaaa2a0c0f27c9e7fbb0301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/384938f75eb7b7ed4b7156fc48f8fb060996aa88413ed9c52f409bfb4c26034646d02399de79bce1076fdc34bf3dbe045c6b9bfc48130ee3e2be4fc27f074618"} 04:35:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:35:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:35:05 INFO - Contents: 04:35:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/456a03bd5c6186cc0a021d83be84f11903f846d66627b05327d9a1af9e7096b84acdb276336d56bdb6f5420390fdef39bb2c57b2eeaaa2a0c0f27c9e7fbb0301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/384938f75eb7b7ed4b7156fc48f8fb060996aa88413ed9c52f409bfb4c26034646d02399de79bce1076fdc34bf3dbe045c6b9bfc48130ee3e2be4fc27f074618"} 04:35:05 INFO - Running post-run listener: copy_logs_to_upload_dir 04:35:05 INFO - Copying logs to upload dir... 04:35:05 INFO - mkdir: /builds/slave/test/build/upload/logs 04:35:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.869191 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2016-03-23 04:35:05.676593) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:35:05.680053) ========= 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/456a03bd5c6186cc0a021d83be84f11903f846d66627b05327d9a1af9e7096b84acdb276336d56bdb6f5420390fdef39bb2c57b2eeaaa2a0c0f27c9e7fbb0301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/384938f75eb7b7ed4b7156fc48f8fb060996aa88413ed9c52f409bfb4c26034646d02399de79bce1076fdc34bf3dbe045c6b9bfc48130ee3e2be4fc27f074618"} build_url:https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011457 build_url: 'https://queue.taskcluster.net/v1/task/Ovz8KWmkTYOarqgXkg2Vqg/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/456a03bd5c6186cc0a021d83be84f11903f846d66627b05327d9a1af9e7096b84acdb276336d56bdb6f5420390fdef39bb2c57b2eeaaa2a0c0f27c9e7fbb0301", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/384938f75eb7b7ed4b7156fc48f8fb060996aa88413ed9c52f409bfb4c26034646d02399de79bce1076fdc34bf3dbe045c6b9bfc48130ee3e2be4fc27f074618"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-23 04:35:05.704788) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:35:05.705102) ========= 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=32c5991c409366f7fec8a718000001d2-1458731458.88393-1363642496 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004485 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 04:35:05.788454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:35:05.788780) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-23 04:35:05.789072) ========= ========= Total master_lag: 0.80 =========