builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-028 starttime: 1465291753.01 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.008339) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.009394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.010098) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.026756) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.027269) ========= 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=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:29:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-06-07 02:29:13 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094784 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.140910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.141647) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018466 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.192770) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.193147) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e70892847544db94d801f80543fe8a7f6d836f90 --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=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:29:14,054 truncating revision to first 12 chars 2016-06-07 02:29:14,054 Setting DEBUG logging. 2016-06-07 02:29:14,054 attempt 1/10 2016-06-07 02:29:14,054 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e70892847544?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 02:29:14,374 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=0.671011 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.878140) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.878514) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.879013) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.879333) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:29:13.890408) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-07 02:29:13.890738) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] 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=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:29:14 INFO - MultiFileLogger online at 20160607 02:29:14 in /builds/slave/test 02:29:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 02:29:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:29:14 INFO - {'append_to_log': False, 02:29:14 INFO - 'base_work_dir': '/builds/slave/test', 02:29:14 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:29:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:29:14 INFO - 'branch': 'Mozilla-Aurora', 02:29:14 INFO - 'buildbot_json_path': 'buildprops.json', 02:29:14 INFO - 'config_files': ('talos/linux_config.py',), 02:29:14 INFO - 'default_actions': ('clobber', 02:29:14 INFO - 'read-buildbot-config', 02:29:14 INFO - 'download-and-extract', 02:29:14 INFO - 'populate-webroot', 02:29:14 INFO - 'create-virtualenv', 02:29:14 INFO - 'install', 02:29:14 INFO - 'run-tests'), 02:29:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:29:14 INFO - 'download_minidump_stackwalk': True, 02:29:14 INFO - 'download_symbols': 'ondemand', 02:29:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:29:14 INFO - 'tooltool.py': '/tools/tooltool.py', 02:29:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:29:14 INFO - '/tools/misc-python/virtualenv.py')}, 02:29:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:29:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:29:14 INFO - 'installer_path': 'installer.exe', 02:29:14 INFO - 'log_level': 'info', 02:29:14 INFO - 'log_name': 'talos', 02:29:14 INFO - 'log_to_console': True, 02:29:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:29:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:29:14 INFO - 'opt_config_files': (), 02:29:14 INFO - 'pip_index': False, 02:29:14 INFO - 'sps_profile': False, 02:29:14 INFO - 'sps_profile_interval': 0, 02:29:14 INFO - 'suite': 'dromaeojs-e10s', 02:29:14 INFO - 'system_bits': '32', 02:29:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:29:14 INFO - 'title': 'talos-linux64-ix-028', 02:29:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:29:14 INFO - 'use_talos_json': True, 02:29:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:29:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:29:14 INFO - 'work_dir': 'build'} 02:29:14 INFO - ##### 02:29:14 INFO - ##### Running clobber step. 02:29:14 INFO - ##### 02:29:14 INFO - Running pre-action listener: _resource_record_pre_action 02:29:14 INFO - Running main action method: clobber 02:29:14 INFO - rmtree: /builds/slave/test/build 02:29:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:29:15 INFO - Running post-action listener: _resource_record_post_action 02:29:15 INFO - ##### 02:29:15 INFO - ##### Finished clobber step (success) 02:29:15 INFO - ##### 02:29:15 INFO - ##### 02:29:15 INFO - ##### Running read-buildbot-config step. 02:29:15 INFO - ##### 02:29:15 INFO - Running pre-action listener: _resource_record_pre_action 02:29:15 INFO - Running main action method: read_buildbot_config 02:29:15 INFO - Using buildbot properties: 02:29:15 INFO - { 02:29:15 INFO - "project": "", 02:29:15 INFO - "product": "firefox", 02:29:15 INFO - "script_repo_revision": "production", 02:29:15 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 02:29:15 INFO - "repository": "", 02:29:15 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs-e10s", 02:29:15 INFO - "buildid": "20160606202128", 02:29:15 INFO - "pgo_build": "True", 02:29:15 INFO - "basedir": "/builds/slave/test", 02:29:15 INFO - "buildnumber": 394, 02:29:15 INFO - "slavename": "talos-linux64-ix-028", 02:29:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 02:29:15 INFO - "platform": "ubuntu64_hw", 02:29:15 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:29:15 INFO - "branch": "mozilla-aurora", 02:29:15 INFO - "repo_path": "releases/mozilla-aurora", 02:29:15 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:29:15 INFO - "stage_platform": "linux64-pgo", 02:29:15 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:29:15 INFO - "slavebuilddir": "test" 02:29:15 INFO - } 02:29:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2. 02:29:15 INFO - Running post-action listener: _resource_record_post_action 02:29:15 INFO - ##### 02:29:15 INFO - ##### Finished read-buildbot-config step (success) 02:29:15 INFO - ##### 02:29:15 INFO - ##### 02:29:15 INFO - ##### Running download-and-extract step. 02:29:15 INFO - ##### 02:29:15 INFO - Running pre-action listener: _resource_record_pre_action 02:29:15 INFO - Running main action method: download_and_extract 02:29:15 INFO - mkdir: /builds/slave/test/build/tests 02:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:15 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 02:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 02:29:15 INFO - Downloaded 1361 bytes. 02:29:15 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:29:15 INFO - Using the following test package requirements: 02:29:15 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:15 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:29:15 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:29:15 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'jsshell-linux-x86_64.zip'], 02:29:15 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:29:15 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:29:15 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:29:15 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:29:15 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:29:15 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:29:15 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:29:15 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:29:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:15 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:17 INFO - Downloaded 24473779 bytes. 02:29:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:18 INFO - Return code: 0 02:29:18 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 02:29:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:18 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 02:29:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip 02:29:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 02:29:19 INFO - Downloaded 24473779 bytes. 02:29:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 02:29:21 INFO - Return code: 0 02:29:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:21 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 02:29:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip 02:29:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 02:29:22 INFO - Downloaded 10833369 bytes. 02:29:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 02:29:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 02:29:22 INFO - Return code: 0 02:29: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')]} 02:29:22 INFO - https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 02:29:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:29:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:29:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:29:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 02:29:23 INFO - Downloaded 63553597 bytes. 02:29:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:29:23 INFO - mkdir: /builds/slave/test/properties 02:29:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:29:23 INFO - Writing to file /builds/slave/test/properties/build_url 02:29:23 INFO - Contents: 02:29:23 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:29:24 INFO - Running post-action listener: _resource_record_post_action 02:29:24 INFO - Running post-action listener: set_extra_try_arguments 02:29:24 INFO - ##### 02:29:24 INFO - ##### Finished download-and-extract step (success) 02:29:24 INFO - ##### 02:29:24 INFO - ##### 02:29:24 INFO - ##### Running populate-webroot step. 02:29:24 INFO - ##### 02:29:24 INFO - Running pre-action listener: _resource_record_pre_action 02:29:24 INFO - Running main action method: populate_webroot 02:29:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:29:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:29:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:29:24 INFO - '--tppagecycles', 02:29:24 INFO - '7'], 02:29:24 INFO - 'tests': ['tsvgm']}}, 02:29:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:29:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:29:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:29:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:29:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:29:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['damp', 'tps']}, 02:29:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'tests': ['damp', 'tps']}, 02:29:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['dromaeo_dom']}, 02:29:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:29:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'other-e10s': {'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['a11yr', 02:29:24 INFO - 'ts_paint', 02:29:24 INFO - 'tpaint', 02:29:24 INFO - 'sessionrestore', 02:29:24 INFO - 'sessionrestore_no_auto_restore', 02:29:24 INFO - 'tabpaint']}, 02:29:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['tsvgx', 02:29:24 INFO - 'tsvgr_opacity', 02:29:24 INFO - 'tart', 02:29:24 INFO - 'tscrollx', 02:29:24 INFO - 'cart']}, 02:29:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:29:24 INFO - 'tsvgr_opacity', 02:29:24 INFO - 'tart', 02:29:24 INFO - 'tscrollx', 02:29:24 INFO - 'cart']}, 02:29:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'talos_options': ['--disable-e10s'], 02:29:24 INFO - 'tests': ['tp5o']}, 02:29:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'tests': ['tp5o']}, 02:29:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'talos_options': ['--disable-e10s', 02:29:24 INFO - '--xperf_path', 02:29:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:24 INFO - 'tests': ['tp5n']}, 02:29:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:29:24 INFO - 'talos_options': ['--xperf_path', 02:29:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:29:24 INFO - 'tests': ['tp5n']}}, 02:29:24 INFO - 'talos.zip': {'path': '', 02:29:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:29:24 INFO - Running post-action listener: _resource_record_post_action 02:29:24 INFO - ##### 02:29:24 INFO - ##### Finished populate-webroot step (success) 02:29:24 INFO - ##### 02:29:24 INFO - ##### 02:29:24 INFO - ##### Running create-virtualenv step. 02:29:24 INFO - ##### 02:29:24 INFO - Running pre-action listener: _resource_record_pre_action 02:29:24 INFO - Running main action method: create_virtualenv 02:29:24 INFO - Creating virtualenv /builds/slave/test/build/venv 02:29:24 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:29:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:29:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:29:24 INFO - Using real prefix '/usr' 02:29:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:29:25 INFO - Installing distribute.............................................................................................................................................................................................done. 02:29:27 INFO - Installing pip.................done. 02:29:27 INFO - Return code: 0 02:29:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 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 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:29:27 INFO - Using env: {'DISPLAY': ':0', 02:29:27 INFO - 'HOME': '/home/cltbld', 02:29:27 INFO - 'LANG': 'en_US.UTF-8', 02:29:27 INFO - 'LANGUAGE': 'en_US:en', 02:29:27 INFO - 'LOGNAME': 'cltbld', 02:29:27 INFO - 'MAIL': '/var/mail/cltbld', 02:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:27 INFO - 'MOZ_NO_REMOTE': '1', 02:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:27 INFO - 'NO_EM_RESTART': '1', 02:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:27 INFO - 'PWD': '/builds/slave/test', 02:29:27 INFO - 'SHELL': '/bin/bash', 02:29:27 INFO - 'SHLVL': '1', 02:29:27 INFO - 'TERM': 'linux', 02:29:27 INFO - 'TMOUT': '86400', 02:29:27 INFO - 'USER': 'cltbld', 02:29:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:27 INFO - '_': '/tools/buildbot/bin/python'} 02:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:27 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 02:29:27 INFO - Cleaning up... 02:29:27 INFO - Return code: 0 02:29:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:29:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:29:27 INFO - Using env: {'DISPLAY': ':0', 02:29:27 INFO - 'HOME': '/home/cltbld', 02:29:27 INFO - 'LANG': 'en_US.UTF-8', 02:29:27 INFO - 'LANGUAGE': 'en_US:en', 02:29:27 INFO - 'LOGNAME': 'cltbld', 02:29:27 INFO - 'MAIL': '/var/mail/cltbld', 02:29:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:27 INFO - 'MOZ_NO_REMOTE': '1', 02:29:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:27 INFO - 'NO_EM_RESTART': '1', 02:29:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:27 INFO - 'PWD': '/builds/slave/test', 02:29:27 INFO - 'SHELL': '/bin/bash', 02:29:27 INFO - 'SHLVL': '1', 02:29:27 INFO - 'TERM': 'linux', 02:29:27 INFO - 'TMOUT': '86400', 02:29:27 INFO - 'USER': 'cltbld', 02:29:27 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:27 INFO - '_': '/tools/buildbot/bin/python'} 02:29:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:27 INFO - Downloading/unpacking psutil>=3.1.1 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:29:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:29 INFO - Installing collected packages: psutil 02:29:29 INFO - Running setup.py install for psutil 02:29:29 INFO - building 'psutil._psutil_linux' extension 02:29:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 02:29:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 02:29:29 INFO - building 'psutil._psutil_posix' extension 02:29:29 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 02:29:29 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 02:29:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:29:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:29:30 INFO - Successfully installed psutil 02:29:30 INFO - Cleaning up... 02:29:30 INFO - Return code: 0 02:29:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:29:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:29:30 INFO - Using env: {'DISPLAY': ':0', 02:29:30 INFO - 'HOME': '/home/cltbld', 02:29:30 INFO - 'LANG': 'en_US.UTF-8', 02:29:30 INFO - 'LANGUAGE': 'en_US:en', 02:29:30 INFO - 'LOGNAME': 'cltbld', 02:29:30 INFO - 'MAIL': '/var/mail/cltbld', 02:29:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:30 INFO - 'MOZ_NO_REMOTE': '1', 02:29:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:30 INFO - 'NO_EM_RESTART': '1', 02:29:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:30 INFO - 'PWD': '/builds/slave/test', 02:29:30 INFO - 'SHELL': '/bin/bash', 02:29:30 INFO - 'SHLVL': '1', 02:29:30 INFO - 'TERM': 'linux', 02:29:30 INFO - 'TMOUT': '86400', 02:29:30 INFO - 'USER': 'cltbld', 02:29:30 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:30 INFO - '_': '/tools/buildbot/bin/python'} 02:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:32 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:29:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:29:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:29:32 INFO - Installing collected packages: mozsystemmonitor 02:29:32 INFO - Running setup.py install for mozsystemmonitor 02:29:32 INFO - Successfully installed mozsystemmonitor 02:29:32 INFO - Cleaning up... 02:29:32 INFO - Return code: 0 02:29:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 02:29:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 02:29:32 INFO - Using env: {'DISPLAY': ':0', 02:29:32 INFO - 'HOME': '/home/cltbld', 02:29:32 INFO - 'LANG': 'en_US.UTF-8', 02:29:32 INFO - 'LANGUAGE': 'en_US:en', 02:29:32 INFO - 'LOGNAME': 'cltbld', 02:29:32 INFO - 'MAIL': '/var/mail/cltbld', 02:29:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:32 INFO - 'MOZ_NO_REMOTE': '1', 02:29:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:32 INFO - 'NO_EM_RESTART': '1', 02:29:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:32 INFO - 'PWD': '/builds/slave/test', 02:29:32 INFO - 'SHELL': '/bin/bash', 02:29:32 INFO - 'SHLVL': '1', 02:29:32 INFO - 'TERM': 'linux', 02:29:32 INFO - 'TMOUT': '86400', 02:29:32 INFO - 'USER': 'cltbld', 02:29:32 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:32 INFO - '_': '/tools/buildbot/bin/python'} 02:29:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:32 INFO - Downloading/unpacking jsonschema==2.5.1 02:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:29:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:34 INFO - Downloading functools32-3.2.3-2.tar.gz 02:29:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:29:34 INFO - warning: no files found matching '*.txt' 02:29:34 INFO - no previously-included directories found matching 'build' 02:29:34 INFO - no previously-included directories found matching 'dist' 02:29:34 INFO - no previously-included directories found matching '.git*' 02:29:34 INFO - Installing collected packages: jsonschema, functools32 02:29:34 INFO - Running setup.py install for functools32 02:29:34 INFO - warning: no files found matching '*.txt' 02:29:34 INFO - no previously-included directories found matching 'build' 02:29:34 INFO - no previously-included directories found matching 'dist' 02:29:34 INFO - no previously-included directories found matching '.git*' 02:29:34 INFO - Successfully installed jsonschema functools32 02:29:34 INFO - Cleaning up... 02:29:35 INFO - Return code: 0 02:29:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:29:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:29:35 INFO - Using env: {'DISPLAY': ':0', 02:29:35 INFO - 'HOME': '/home/cltbld', 02:29:35 INFO - 'LANG': 'en_US.UTF-8', 02:29:35 INFO - 'LANGUAGE': 'en_US:en', 02:29:35 INFO - 'LOGNAME': 'cltbld', 02:29:35 INFO - 'MAIL': '/var/mail/cltbld', 02:29:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:35 INFO - 'MOZ_NO_REMOTE': '1', 02:29:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:35 INFO - 'NO_EM_RESTART': '1', 02:29:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:35 INFO - 'PWD': '/builds/slave/test', 02:29:35 INFO - 'SHELL': '/bin/bash', 02:29:35 INFO - 'SHLVL': '1', 02:29:35 INFO - 'TERM': 'linux', 02:29:35 INFO - 'TMOUT': '86400', 02:29:35 INFO - 'USER': 'cltbld', 02:29:35 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:35 INFO - '_': '/tools/buildbot/bin/python'} 02:29:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:35 INFO - Downloading/unpacking blobuploader==1.2.4 02:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:37 INFO - Downloading blobuploader-1.2.4.tar.gz 02:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:29:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:29:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:38 INFO - Downloading docopt-0.6.1.tar.gz 02:29:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:29:38 INFO - Installing collected packages: blobuploader, requests, docopt 02:29:38 INFO - Running setup.py install for blobuploader 02:29:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:29:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:29:38 INFO - Running setup.py install for requests 02:29:38 INFO - Running setup.py install for docopt 02:29:38 INFO - Successfully installed blobuploader requests docopt 02:29:38 INFO - Cleaning up... 02:29:38 INFO - Return code: 0 02:29:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:38 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 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:38 INFO - Using env: {'DISPLAY': ':0', 02:29:38 INFO - 'HOME': '/home/cltbld', 02:29:38 INFO - 'LANG': 'en_US.UTF-8', 02:29:38 INFO - 'LANGUAGE': 'en_US:en', 02:29:38 INFO - 'LOGNAME': 'cltbld', 02:29:38 INFO - 'MAIL': '/var/mail/cltbld', 02:29:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:38 INFO - 'MOZ_NO_REMOTE': '1', 02:29:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:38 INFO - 'NO_EM_RESTART': '1', 02:29:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:38 INFO - 'PWD': '/builds/slave/test', 02:29:38 INFO - 'SHELL': '/bin/bash', 02:29:38 INFO - 'SHLVL': '1', 02:29:38 INFO - 'TERM': 'linux', 02:29:38 INFO - 'TMOUT': '86400', 02:29:38 INFO - 'USER': 'cltbld', 02:29:38 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:38 INFO - '_': '/tools/buildbot/bin/python'} 02:29:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:38 INFO - Running setup.py (path:/tmp/pip-vsz4iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:39 INFO - Running setup.py (path:/tmp/pip-SAkEUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:39 INFO - Running setup.py (path:/tmp/pip-YWOQ1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:39 INFO - Running setup.py (path:/tmp/pip-dUuT34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:39 INFO - Running setup.py (path:/tmp/pip-GEVSHw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:39 INFO - Running setup.py (path:/tmp/pip-jj7mPD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:39 INFO - Running setup.py (path:/tmp/pip-yEaTcl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:39 INFO - Running setup.py (path:/tmp/pip-gaeOhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:39 INFO - Running setup.py (path:/tmp/pip-G8J04c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:39 INFO - Running setup.py (path:/tmp/pip-O9jwa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:39 INFO - Running setup.py (path:/tmp/pip-f2K3ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:39 INFO - Running setup.py (path:/tmp/pip-VG3D55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:39 INFO - Running setup.py (path:/tmp/pip-V4qUX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:39 INFO - Running setup.py (path:/tmp/pip-hsUT4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:39 INFO - Running setup.py (path:/tmp/pip-zfvHtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:40 INFO - Running setup.py (path:/tmp/pip-YGQj7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:40 INFO - Running setup.py (path:/tmp/pip-Qe0VRP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:29:40 INFO - Running setup.py install for manifestparser 02:29:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Running setup.py install for mozcrash 02:29:40 INFO - Running setup.py install for mozdebug 02:29:40 INFO - Running setup.py install for mozdevice 02:29:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Running setup.py install for mozfile 02:29:40 INFO - Running setup.py install for mozhttpd 02:29:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Running setup.py install for mozinfo 02:29:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Running setup.py install for mozInstall 02:29:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:29:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Running setup.py install for mozleak 02:29:41 INFO - Running setup.py install for mozlog 02:29:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Running setup.py install for moznetwork 02:29:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Running setup.py install for mozprocess 02:29:41 INFO - Running setup.py install for mozprofile 02:29:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Running setup.py install for mozrunner 02:29:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Running setup.py install for mozscreenshot 02:29:41 INFO - Running setup.py install for moztest 02:29:41 INFO - Running setup.py install for mozversion 02:29:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:29:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:29:41 INFO - Cleaning up... 02:29:41 INFO - Return code: 0 02:29:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:42 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 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 02:29:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:42 INFO - Using env: {'DISPLAY': ':0', 02:29:42 INFO - 'HOME': '/home/cltbld', 02:29:42 INFO - 'LANG': 'en_US.UTF-8', 02:29:42 INFO - 'LANGUAGE': 'en_US:en', 02:29:42 INFO - 'LOGNAME': 'cltbld', 02:29:42 INFO - 'MAIL': '/var/mail/cltbld', 02:29:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:42 INFO - 'MOZ_NO_REMOTE': '1', 02:29:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:42 INFO - 'NO_EM_RESTART': '1', 02:29:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:42 INFO - 'PWD': '/builds/slave/test', 02:29:42 INFO - 'SHELL': '/bin/bash', 02:29:42 INFO - 'SHLVL': '1', 02:29:42 INFO - 'TERM': 'linux', 02:29:42 INFO - 'TMOUT': '86400', 02:29:42 INFO - 'USER': 'cltbld', 02:29:42 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:42 INFO - '_': '/tools/buildbot/bin/python'} 02:29:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:29:42 INFO - Running setup.py (path:/tmp/pip-0MbJ3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:29:42 INFO - Running setup.py (path:/tmp/pip-iY9nsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:29:42 INFO - Running setup.py (path:/tmp/pip-uwzIc0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:29:42 INFO - Running setup.py (path:/tmp/pip-zCyvLe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:29:42 INFO - Running setup.py (path:/tmp/pip-KzDnVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:29:42 INFO - Running setup.py (path:/tmp/pip-f_6m4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:29:42 INFO - Running setup.py (path:/tmp/pip-nK_dxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:29:42 INFO - Running setup.py (path:/tmp/pip-ysShtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:29:42 INFO - Running setup.py (path:/tmp/pip-Ge1IBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:29:42 INFO - Running setup.py (path:/tmp/pip-Q8dUr_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:29:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:29:42 INFO - Running setup.py (path:/tmp/pip-5IaufW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:29:43 INFO - Running setup.py (path:/tmp/pip-W2lyVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:29:43 INFO - Running setup.py (path:/tmp/pip-Q5DMUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:29:43 INFO - Running setup.py (path:/tmp/pip-JgsJqU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:43 INFO - Running setup.py (path:/tmp/pip-3QQrtP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:29:43 INFO - Running setup.py (path:/tmp/pip-vbVOXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 02:29:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:29:43 INFO - Running setup.py (path:/tmp/pip-kVsO4U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 02:29:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:45 INFO - Downloading blessings-1.6.tar.gz 02:29:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:29:45 INFO - Installing collected packages: blessings 02:29:45 INFO - Running setup.py install for blessings 02:29:45 INFO - Successfully installed blessings 02:29:45 INFO - Cleaning up... 02:29:45 INFO - Return code: 0 02:29:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:29:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:45 INFO - Reading from file tmpfile_stdout 02:29:45 INFO - Current package versions: 02:29:45 INFO - argparse == 1.2.1 02:29:45 INFO - blessings == 1.6 02:29:45 INFO - blobuploader == 1.2.4 02:29:45 INFO - docopt == 0.6.1 02:29:45 INFO - functools32 == 3.2.3-2 02:29:45 INFO - jsonschema == 2.5.1 02:29:45 INFO - manifestparser == 1.1 02:29:45 INFO - mozInstall == 1.12 02:29:45 INFO - mozcrash == 0.17 02:29:45 INFO - mozdebug == 0.1 02:29:45 INFO - mozdevice == 0.48 02:29:45 INFO - mozfile == 1.2 02:29:45 INFO - mozhttpd == 0.7 02:29:45 INFO - mozinfo == 0.9 02:29:45 INFO - mozleak == 0.1 02:29:45 INFO - mozlog == 3.2 02:29:45 INFO - moznetwork == 0.27 02:29:45 INFO - mozprocess == 0.22 02:29:45 INFO - mozprofile == 0.28 02:29:45 INFO - mozrunner == 6.11 02:29:45 INFO - mozscreenshot == 0.1 02:29:45 INFO - mozsystemmonitor == 0.3 02:29:45 INFO - moztest == 0.7 02:29:45 INFO - mozversion == 1.4 02:29:45 INFO - psutil == 3.1.1 02:29:45 INFO - requests == 1.2.3 02:29:45 INFO - wsgiref == 0.1.2 02:29:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:29:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29:45 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 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 02:29:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 02:29:45 INFO - Using env: {'DISPLAY': ':0', 02:29:45 INFO - 'HOME': '/home/cltbld', 02:29:45 INFO - 'LANG': 'en_US.UTF-8', 02:29:45 INFO - 'LANGUAGE': 'en_US:en', 02:29:45 INFO - 'LOGNAME': 'cltbld', 02:29:45 INFO - 'MAIL': '/var/mail/cltbld', 02:29:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:45 INFO - 'MOZ_NO_REMOTE': '1', 02:29:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:45 INFO - 'NO_EM_RESTART': '1', 02:29:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:45 INFO - 'PWD': '/builds/slave/test', 02:29:45 INFO - 'SHELL': '/bin/bash', 02:29:45 INFO - 'SHLVL': '1', 02:29:45 INFO - 'TERM': 'linux', 02:29:45 INFO - 'TMOUT': '86400', 02:29:45 INFO - 'USER': 'cltbld', 02:29:45 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:45 INFO - '_': '/tools/buildbot/bin/python'} 02:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 02:29:46 INFO - Cleaning up... 02:29:46 INFO - Return code: 0 02:29:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29: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', 'jsonschema'] in /builds/slave/test/build 02:29: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 jsonschema 02:29:46 INFO - Using env: {'DISPLAY': ':0', 02:29:46 INFO - 'HOME': '/home/cltbld', 02:29:46 INFO - 'LANG': 'en_US.UTF-8', 02:29:46 INFO - 'LANGUAGE': 'en_US:en', 02:29:46 INFO - 'LOGNAME': 'cltbld', 02:29:46 INFO - 'MAIL': '/var/mail/cltbld', 02:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:46 INFO - 'MOZ_NO_REMOTE': '1', 02:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:46 INFO - 'NO_EM_RESTART': '1', 02:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:46 INFO - 'PWD': '/builds/slave/test', 02:29:46 INFO - 'SHELL': '/bin/bash', 02:29:46 INFO - 'SHLVL': '1', 02:29:46 INFO - 'TERM': 'linux', 02:29:46 INFO - 'TMOUT': '86400', 02:29:46 INFO - 'USER': 'cltbld', 02:29:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:46 INFO - '_': '/tools/buildbot/bin/python'} 02:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:29:46 INFO - Cleaning up... 02:29:46 INFO - Return code: 0 02:29:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:29: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')]} 02:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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')]} 02:29:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:29:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:29: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc389848f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12bf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x138c020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, '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': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 02:29: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', 'flake8'] in /builds/slave/test/build 02:29: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 flake8 02:29:46 INFO - Using env: {'DISPLAY': ':0', 02:29:46 INFO - 'HOME': '/home/cltbld', 02:29:46 INFO - 'LANG': 'en_US.UTF-8', 02:29:46 INFO - 'LANGUAGE': 'en_US:en', 02:29:46 INFO - 'LOGNAME': 'cltbld', 02:29:46 INFO - 'MAIL': '/var/mail/cltbld', 02:29:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:29:46 INFO - 'MOZ_NO_REMOTE': '1', 02:29:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:29:46 INFO - 'NO_EM_RESTART': '1', 02:29:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:29:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:29:46 INFO - 'PWD': '/builds/slave/test', 02:29:46 INFO - 'SHELL': '/bin/bash', 02:29:46 INFO - 'SHLVL': '1', 02:29:46 INFO - 'TERM': 'linux', 02:29:46 INFO - 'TMOUT': '86400', 02:29:46 INFO - 'USER': 'cltbld', 02:29:46 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:29:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:29:46 INFO - '_': '/tools/buildbot/bin/python'} 02:29:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:29:46 INFO - Downloading/unpacking flake8 02:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:29:48 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:29:48 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:29:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:29:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:29:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:29:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:49 INFO - no previously-included directories found matching 'docs/_build' 02:29:49 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:29:49 INFO - Running setup.py install for pep8 02:29:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:29:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:29:49 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:29:49 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:29:49 INFO - no previously-included directories found matching 'docs/_build' 02:29:49 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:29:49 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:29:49 INFO - Cleaning up... 02:29:49 INFO - Return code: 0 02:29:49 INFO - Running post-action listener: _resource_record_post_action 02:29:49 INFO - Running post-action listener: _start_resource_monitoring 02:29:49 INFO - Starting resource monitoring. 02:29:49 INFO - ##### 02:29:49 INFO - ##### Finished create-virtualenv step (success) 02:29:49 INFO - ##### 02:29:49 INFO - ##### 02:29:49 INFO - ##### Running install step. 02:29:49 INFO - ##### 02:29:49 INFO - Running pre-action listener: _resource_record_pre_action 02:29:49 INFO - Running main action method: install 02:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:29:49 INFO - Reading from file tmpfile_stdout 02:29:49 INFO - Detecting whether we're running mozinstall >=1.0... 02:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:29:49 INFO - Reading from file tmpfile_stdout 02:29:49 INFO - Output received: 02:29:49 INFO - Usage: mozinstall [options] installer 02:29:49 INFO - Options: 02:29:49 INFO - -h, --help show this help message and exit 02:29:49 INFO - -d DEST, --destination=DEST 02:29:49 INFO - Directory to install application into. [default: 02:29:49 INFO - "/builds/slave/test"] 02:29:49 INFO - --app=APP Application being installed. [default: firefox] 02:29:49 INFO - mkdir: /builds/slave/test/build/application 02:29:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 02:29:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 02:30:05 INFO - Reading from file tmpfile_stdout 02:30:05 INFO - Output received: 02:30:05 INFO - /builds/slave/test/build/application/firefox/firefox 02:30:05 INFO - Running post-action listener: _resource_record_post_action 02:30:05 INFO - ##### 02:30:05 INFO - ##### Finished install step (success) 02:30:05 INFO - ##### 02:30:05 INFO - ##### 02:30:05 INFO - ##### Running run-tests step. 02:30:05 INFO - ##### 02:30:05 INFO - Running pre-action listener: _resource_record_pre_action 02:30:05 INFO - Running main action method: run_tests 02:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:30:05 INFO - Python 2.7.3 02:30:05 INFO - Return code: 0 02:30:05 INFO - grabbing minidump binary from tooltool 02:30:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:30:05 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x141e2e0>, '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 0x138a140>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x138a5d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:30:05 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 02:30:05 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 02:30:05 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 02:30:05 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:30:05 INFO - Return code: 0 02:30:05 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:30:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:30:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:30:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:30:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:30:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:30:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:30:06 INFO - Return code: 0 02:30:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:30:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-028 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:30:06 INFO - Using env: {'DISPLAY': ':0', 02:30:06 INFO - 'HOME': '/home/cltbld', 02:30:06 INFO - 'LANG': 'en_US.UTF-8', 02:30:06 INFO - 'LANGUAGE': 'en_US:en', 02:30:06 INFO - 'LOGNAME': 'cltbld', 02:30:06 INFO - 'MAIL': '/var/mail/cltbld', 02:30:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:30:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:30:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:30:06 INFO - 'MOZ_NO_REMOTE': '1', 02:30:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:30:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:30:06 INFO - 'NO_EM_RESTART': '1', 02:30:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:30:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:30:06 INFO - 'PWD': '/builds/slave/test', 02:30:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:30:06 INFO - 'SHELL': '/bin/bash', 02:30:06 INFO - 'SHLVL': '1', 02:30:06 INFO - 'TERM': 'linux', 02:30:06 INFO - 'TMOUT': '86400', 02:30:06 INFO - 'USER': 'cltbld', 02:30:06 INFO - 'XDG_SESSION_COOKIE': '836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000', 02:30:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:30:06 INFO - '_': '/tools/buildbot/bin/python'} 02:30:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-028', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:30:06 INFO - mozversion application_buildid: 20160606202128 02:30:06 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:30:06 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:30:06 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:30:06 INFO - mozversion application_name: Firefox 02:30:06 INFO - mozversion application_remotingname: firefox-dev 02:30:06 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:06 INFO - mozversion application_vendor: Mozilla 02:30:06 INFO - mozversion application_version: 49.0a2 02:30:06 INFO - mozversion platform_buildid: 20160606202128 02:30:06 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:30:06 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:30:06 INFO - mozversion platform_version: 49.0a2 02:30:06 INFO - using testdate: 1465291806 02:30:06 INFO - actual date: 1465291806 02:30:06 INFO - starting webserver on 'localhost:57206' 02:30:06 INFO - SUITE-START | Running 2 tests 02:30:06 INFO - TEST-START | dromaeo_css 02:30:06 INFO - operating with platform_type : linux_ 02:30:06 INFO - Initialising browser for dromaeo_css test... 02:30:06 INFO - TEST-INFO | started process 8917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRsoUU/profile http://localhost:57206/getInfo.html) 02:30:11 INFO - PROCESS | 8917 | __metrics Screen width/height:1600/1200 02:30:11 INFO - PROCESS | 8917 | colorDepth:24 02:30:11 INFO - PROCESS | 8917 | Browser inner width/height: 1024/697 02:30:11 INFO - PROCESS | 8917 | __metrics 02:30:12 ERROR - PROCESS | 8917 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:30:13 INFO - TEST-INFO | 8917: exit 0 02:30:13 INFO - Browser initialized. 02:30:13 INFO - Running cycle 1/1 for dromaeo_css test... 02:30:13 INFO - TEST-INFO | started process 9049 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphRsoUU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:30:24 INFO - PROCESS | 9049 | RSS: Main: 155779072 02:30:24 INFO - PROCESS | 9049 | 02:31:14 INFO - PROCESS | 9049 | 1465291874540 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 02:33:22 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57206/tests/dromaeo/cssquery-ext.html) 02:33:23 INFO - PROCESS | 9049 | RSS: Main: 160026624 02:33:23 INFO - PROCESS | 9049 | 02:36:25 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-ext.html (next: http://localhost:57206/tests/dromaeo/cssquery-jquery.html) 02:36:26 INFO - PROCESS | 9049 | RSS: Main: 157442048 02:36:26 INFO - PROCESS | 9049 | 02:39:28 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57206/tests/dromaeo/cssquery-mootools.html) 02:39:28 INFO - PROCESS | 9049 | RSS: Main: 156725248 02:39:28 INFO - PROCESS | 9049 | 02:42:30 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57206/tests/dromaeo/cssquery-prototype.html) 02:42:31 INFO - PROCESS | 9049 | RSS: Main: 156528640 02:42:31 INFO - PROCESS | 9049 | 02:45:33 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57206/tests/dromaeo/cssquery-yui.html) 02:45:34 INFO - PROCESS | 9049 | RSS: Main: 158810112 02:45:34 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | Cycle 1(1): loaded http://localhost:57206/tests/dromaeo/cssquery-yui.html (next: http://localhost:57206/tests/dromaeo/cssquery-dojo.html) 02:48:36 INFO - PROCESS | 9049 | RSS: Main: 158720000 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | __start_tp_report 02:48:36 INFO - PROCESS | 9049 | _x_x_mozilla_page_load 02:48:36 INFO - PROCESS | 9049 | _x_x_mozilla_page_load_details 02:48:36 INFO - PROCESS | 9049 | |i|pagename|runs| 02:48:36 INFO - PROCESS | 9049 | |0;dojo.html;3369.6461871503475;3373.5951685797704;3420.914477138073;3423.657634236576;3441.0021093882774;5742.655440673562;5835.970820145904;5844.444777746118;5862.706864656766;5885.970570147154;5881.941180588193;5887.735051922663;5904.202932604097;5910.379410161925;5926.199963004993;5243.213517972306;5351.518363347298;5396.784128634869;5397.973010134944;5401.108817045183;5284;5297.417284098746;5425.240466334716;5429.728513574325;5446.537044351235;5334;5366.8926621467745;5376;5401.027814993299;5427.6472029318165;5283.075461794209;5288.788448462057;5372.597055220874;5374.167004114369;5384.138537833967;5249.081410753103;5300.628955973083;5317.707526086064;5362.249285100089;5365.839024829262;5548.667079975174;5631.549476041907;5674.460926212003;5679.034564124109;5724.856878578069;6290.182276304097;6299.496040316763;6300.464460520861;6310.684465776692;6323.241211054703;6118.162361256266;6308.810735677937;6357.332480089616;6360.427561519439;6363.96818015907;5807.128930660392;5838.795642152504;5859.648421094748;5902.2622172228475;5906.232189815297;6360.681965901779;6416.358364163546;6429.839254018687;6442.484601231984;6447.3552644735155;5921.259842519685;6049.879002419927;6130.816075517741;6172.475339596184;6203.844903877439;6114.875284800388;6260.874782504325;6263.655498947511;6270.31026587075;6277.278113016971;6171.537134714914;6215.627062376272;6222.471089957314;6224.035274532454;6238.157848690369;6099.054646529795;6133.701927635063;6150.384961503813;6215.285242197205;6216.129741836146;4734.053189362073;4747.2879068140055;4750;4759.928601070987;4769.642276829251;4230.682698797603;4239.258129827268;4240.660747140221;4251.44731184944;4254.276772948606;5909.763609455659;5970.820875373745;5984.222051133324;5993.700314984233;6034.818955431344;6063.969680151659;6189.690515474208;6256.499480041586;6266.373362663789;6346.143270658495;6007.429294217042;6039.365866584033;6044.727987240584;6045.395460453919;6047.7278522466595;5249.107651699221;5409.053415652324;5444.373897001817;5481.123020316731;5519.972400138054;6639.668016599151;6657.034729964128;6677.799666010027;6682.264950855402;6686.966565167143;6122.693865306628;6434.967825160844;6462.192225971754;6465.709043093166;6467.062275970052;6385.968070159805;6408.102865598727;6422.518311126591;6507.577007494498;6509.381608747161;6233.376662333731;6238.189035425366;6239.7504099837315;6241.063840423973;6246.875062498633;6155.2613686356135;6190.7214175363115;6343.207099112611;6360.650164241011;6368;6040.063790112539;6115.755369785159;6148.077788331786;6156.630602163885;6185.103160041859;6122.846928826637;6158.507319414526;6164;6182.474489668429;6196.349383314687;5813.94186058134;5877.706114694162;5916.49709774674;6031.396860313934;6070.666113363807;6150.692465376803;6179;6182.28903676083;6200.596961197508;6204.968975155095;6055.333913269449;6066.787662431793;6070;6070.586362324697;6089.451949324405 02:48:36 INFO - PROCESS | 9049 | |1;ext.html;594.1147689941988;643.1510406263732;644.7259914536321;659.6833519910446;661.6394065234448;45462.545374546244;46504;46685.533144668545;51138.74430627851;51204.74397628016;47783.76108119463;48421.27368089482;48454.51545484544;48548.02903941928;48551.757241213745;9074.500902450363;9313.813723725521;9320.62717491303;9321;9324;9035.819283614324;9126.26989840811;9129.45223286605;9143.314251431137;9144;9156.908430915706;9266;9267.119623635745;9274.304427167956;9282.675106371278;9154.908450915505;9157.542122893828;9169.770755731093;9187.402818816823;9227.031161728022;9169.633214671405;9176.724698259062;9201.815963680756;9219.400738952014;9275.489848058354;45074.77462612666;45342.31986520205;45427.54572454299;45502.544974550496;45664;3752.5309336332957;3883.0486530799853;4013.097053163044;4274.487061552633;4581.725096494221;34465;34598.135046623785;34960.825195873855;35108.64891351079;35134.82432587821;4532.864014079583;4537.750423726694;4606.147862645421;4620.399348084761;4631.698939568917;397087.0145649282;401031;401605;403945;404282;37654.24691506154;60774.39225607687;60775.69612151911;61218.69390653107;61800.69099654563;38465.80767096147;40191.397129043085;40199.79900100539;40201.195976080315;40236.19527609432;16187.19064046793;16330.101844398434;16340.75488867668;16367.181640917906;16406.507804765875;13381.933090334485;13518.459261629621;13518.59444216675;13524.59426217215;13558.796618050737;9284.814303713887;9294.721158365124;9298.349115561981;9318.767030824283;9357.812843743088;3536.310419468179;3568.0901370150445;3644.1982763791925;3649.7445178837756;3667.624640759715;1073.2862646340097;1084.1272775415866;1085.5603480590373;1091.9945400272948;1161.9302841829517;32430;33529;33859.492107618404;34029;34262.48606270908;1129.5989923577176;1172.1091970102614;1187.8812118788053;1198.6943329451108;1283.7560863435917;17876.19557119933;17895;17975.191116399794;17996.640067198583;18010.36963706264;559554;559573;579878;579901;957055;61344.38655613476;62064;62227.377726222156;62361;62607.37392626107;1382.4953891829612;1388.3891087921281;1392.088182240634;1400.5798260521804;1420.254366457618;32058.19854503656;32239.677603223667;32351;33120.66879331176;33593.99218023463;52512;52574.737126314125;52652;52686.47313526969;52866;385874;388043;388282;390662;390985;29608.703912960595;30181.547276790425;30252.5462118064;30308.545371819;30444.086677399715;49272.50727492679;50738.49261507337;50793.746031269606;50885;51013;42161.57838421576;42173.578264216965;42651;43017.569824302605;43955.560444395145;39520;40562;40673.59326406698;41526.584734152275;41815.7909210452;41112.794436028824;41867.7906610465;42177.36733948932;42684.78657606692;42904.78547607242;36863.44704829376;37031.44452833156;37254.25491490209;37702.62297377101;38172.80913595414;28466.857665711537;28575.28561785972;28645.713542864305;28771.71228287774;28818 02:48:36 INFO - PROCESS | 9049 | |2;jquery.html;432.59552318582126;434.65662126919733;435.22456995667494;437.58648077566704;444.7576071041282;18514.444566663005;19613.705794413076;20322.89838550807;20508.077136528856;20541.4864628384;19562.41312760616;20224.898875505638;20355.999999999964;21250;21285.57428851422;5602.663840169593;5712.685802280873;5722.113072473773;5753.971230143864;5774.364819869811;5787.189793428924;5859.091840764689;5935.910961335583;5948.375420580842;5994.610350327237;5775.047117225653;5842;5868.706564671771;5876.588638795286;5880.794172203974;5744.999999999979;5845.85385365365;5867.178594996704;5903.704814759245;5920.467157955762;5281.287026251445;5300.072487314743;5305.734713264322;5307.177387504904;5317.229001794757;23687.881560592086;24300.39249018771;24484.14305499317;24519;24557.631635525482;2357.951853495778;2430.562498750224;2447.1312683997103;2822.7459528642316;2836.6879643239226;14514.927425362912;14996.925015374962;15253.08481491114;15269.923650381677;15453;2038.398672391648;2061.072517367191;2071.5856828634332;2142.721446211998;2178.2920550821045;82175.589122054;82520.58739706322;82548;83159.16840831575;83975;11091.112710983101;11219.214654974237;11450.656480305604;11827.586034488751;12020.759584808255;15727.213639317988;15826.129562874152;15846;15857.920710396374;15948.2823272953;8722.86915696265;8734.825303493895;8885.733427997171;8911;8958.86561701575;8282.296004839536;8387.706430274911;8570.700025499078;8615.439996400213;8626.870596941051;7015.158181018209;7129.394001509826;7131.536450130829;7137.715211262022;7162.892556611655;2056.6812144117685;2058.1664425907234;2058.6294466996083;2118.9364319070146;2126.064531606088;944.254039308952;1029.7580068683853;1086.3264775838873;1137.954481820718;1142.257532603814;20068.598628027357;20348.89825550863;20453.693194602092;20613.896930515253;20948.743075415525;1059.3685723985132;1063.5161001744189;1067.290251982423;1095.1567293184203;1131.9264247823864;11814.822777658343;11881.465334059989;11881.5841445549;12075.45660445282;12110.576129835414;503937;517733;522347;523145;529906;68717.65641171762;77079.61460192663;77122.99999999888;83434.16565834386;86955.56522217348;1093.912487001038;1095.2606990281529;1105.0220554809052;1131.4116659337262;1132.445101900063;18307.35924242645;18576;18613.44159675212;18693.626127477102;18886;39521.20957580775;39571.01072473096;41015.58984410237;41023.58976410198;41600.37599435951;53901.46098539121;55190.17214741702;55600;55778.44221557733;56213.15680264717;9037.593308301273;9136.406133601295;9185.265178785814;9226.123518265755;9466.905330946602;14010.369533371226;14294.928525357307;14355.928220358832;14360.281985900872;14436.711265774416;10226.181905447695;11921;12605.621831344708;12640.828526586021;12719.300438475973;11937.761244775229;12137.817932730839;12333.136680432284;12504;12679.556215532411;10756.117679405916;12779.36103194855;12843;12855.87144128584;13002.674933126747;8806.779830504032;8935.463872167691;9158.40470369424;9190.58642361082;9309.906900931175;12626.55807046749;12659.620211393672;12834.229946203257;12877.484900603871;12879 02:48:36 INFO - PROCESS | 9049 | |3;mootools.html;1598.5603958911302;1624.204139971414;1875.1374367790816;1909.6085302512986;1949.2787668562626;8533.232009119178;9367.437953722781;9391.201747851432;10034.448105354202;10067.194624430056;9081.318901082428;9385.249180065595;9403.811923761521;9441.575129119188;9506;2481.305234534329;2487.2413913756295;2496.2386472125995;2497.9750202498017;2507.4608959073794;2450.4608986023136;2487.1046423287694;2507.2352932355625;2507.4232926426935;2510.0587279770084;2518.7229404765462;2527.027094568595;2553.540362734707;2559.8976040958432;2566.8973241070335;2428.295794219674;2461.064795377754;2475.5296493666237;2492.9002839886384;2497.4880149569294;2476.2818782553036;2485.63958226058;2513.246026192135;2544.0459827564664;2551.4769472258145;9681.273904457123;9713.90286097144;9716.174125199366;9745;9760.755981100458;5773.88452230953;5774.307083150007;5809.3609702932645;5838.328592211908;5841.620294680833;3659.1949771050326;3724.5902950675404;3805.9429108563395;3829.1384438501113;3868.355948721782;1186.7151883547972;1197.0902114393036;1214.0287769784225;1214.168294718121;1219.378117160246;14252.073615215082;14262.144271343648;14300.642483937776;14306.356213970397;14359.138451692932;4908.361912951294;4996.225585034325;5006.74966251686;5079.4412614612365;5143.922841157386;11623.76752464946;11629.651110466699;11839.11206659504;12078;12174.939125304494;5919.112133179971;5956.1065840123465;5958.433948774859;5970.731317090655;5983.910241346383;4681.789319480631;5221.843344699665;5229.79714665629;5337.8131765388025;5481.917771233435;4388;4394.318880573516;4459.910801783946;4465.285554311295;4511.571400716926;1341.6511706956067;1365.5220672764651;1373.4300265389952;1381.7789153735355;1385.7020740540831;911.4166933162782;940.7977284883783;1034.6947650443137;1042.817506936283;1081.6484642491064;6551.344865513411;6551.80344589663;6600.405963463311;6634.270230274666;6778.423833974168;455.29429384453965;457.2295681776218;459.4922610515399;499.59532778449574;503.2174967924912;4674.11191873543;4698.741569213657;4732.1718699227495;4812.5668689818085;4842.273658951115;12028.759424811455;12210.145289829805;12464.252144871336;12539.623811285675;12546.309952952493;12034.75930481403;12252.632421027205;12366.319852408024;12439.440225189706;12444.81332780009;9106.908930910871;9164.587593558306;9247.583858726373;9250.306227033;9308.767280818034;6695.598264104169;6697.966510167613;6704.195496540447;6704.597724136567;6806.353396427331;11222.046126079049;11338.546458141582;11409.25839820409;11427.485763140512;11489.080873530265;11379.487923043318;11579.073674105883;11603.245789023686;11641.243319184226;11684.88315116838;7645.503042302233;8197.057338406159;8353.916460835313;8759.781005474913;8791.120887911158;9407.059294070812;9422.764430889009;9478.715638530855;9503.66737164196;9512.23902087845;8215.260626543639;8470.49177049379;8496.915030849612;8514.403991720521;8590.398672092893;8130.065042520186;8367.623456944573;8422.83154336922;8493.278071364004;8553.529555874487;7432.070991126109;7520.661570229462;7538.849223015619;7548.4716069874585;7567.091948966159;5330.520253177233;5596.832095037155;5610.5231055360755;5676.34722006958;5796.21751063601;5488.862778430412;5519.227308176778;5544.861378465571;5623.746931388179;5711.771529138788 02:48:36 INFO - PROCESS | 9049 | |4;prototype.html;355.95372601561803;358.4157822748919;359.12911190363394;364.2750925657941;367.53873888270215;5787.913181302284;5859.531237501001;5863.736131874065;5867.647941123536;5929.229200203968;5602.803901863435;5798.42015798421;5801.216835727176;5835.299764028312;5848.795292164775;4501.932471012938;4539.886502837422;4546.113507865967;4561.657875659323;4576.794044267999;4580.175568397687;4583.472900616422;4585.9541404586025;4592.2905485763395;4613.423322084739;4537.659675524333;4578.153041687282;4585.679002469828;4597.4483062032605;4601.792919318638;4189.329707246841;4478.126765280772;4485.147821913826;4493.5506449355125;4510.233260345733;3962.7424217425773;3982.5021872265966;3986.202759448122;3992.5608183099835;3995.820188091543;5584.776608935637;5594.916076258859;5606.943930560724;5615.354234263031;5632.549396048347;5062.974685126551;5150.712321919483;5181.922271165936;5215.6609820361555;5221.582273418117;6054.878902421927;6124.785632502885;6130.754769809247;6145.047517634774;6160.02879078695;4212.49450065991;4348.4999225089205;4387.407699960497;4406.383106365111;4417.160739459525;6167.907481387782;6264.498840092781;6314.905276420857;6333.8416539586415;6358.58669186506;4429.2027435062;4438.134563760036;4446.5331140230455;4452.888677783017;4475.597196252288;4501.122281155209;4536.72779633223;4537.8184872604725;4552.1806074906835;4559.1307563898645;4949.183384741549;5127.154019586801;5127.923136141378;5141.151709967889;5179.171332586768;6164.815055548341;6178.598391104564;6183.876322473526;6189.783357582463;6199.380061993765;1525.062086816622;1552.9905561384965;1556.894604830583;1565.9273397722598;1568.968620627581;962.0187408842941;982.8132654795565;985.5023213277392;1001.7095042437758;1009.9697009089739;5273.048971880352;5288.889333239986;5302.469753024667;5318.893622127536;5334.41280978725;5532.114861622121;5561.777528898799;5594.692291923902;5636.971815140898;5664.830055098271;5335.599830012765;5392.245085688007;5526.784107496344;6013.759449622054;6025.9096113558335;3377.6622337766516;3399.7280217582534;3403.8638454461543;3425.3491836551475;3432.1419645088727;6214.347493513116;6541.182352205974;6591.604503729792;6603.537752357289;6668.933310666928;6448.838779030468;6474.741010359533;6500.804975850732;6518.837029074216;6523;6295.118683384421;6534.346565343428;6582.605043697394;6605.306442823435;6622.238442579069;6310.400511951358;6319.431251187415;6338;6355.523335749745;6363.809085727436;5956.731947062306;6290.748370065146;6296.748130074746;6308.968455157695;6327.493800495858;6498.772542960974;6537.738490460329;6543.574667646588;6554.918438457601;6572.718319927568;4410.933835992527;4468.932966005447;4469.798859051415;4484.641228701761;4498.955010449854;6254.655993920378;6323.336049714714;6341.587796793194;6341.936580634135;6492.967535162483;6120.908186377297;6133.969330153321;6162.907556386747;6163.260408750979;6176.258848938156;5915.763369465345;6106.1146133811235;6110.175126357884;6151.723172457339;6191.690415479118;5990.940090599038;6010.54920880927;6049.697515124314;6055.969720151371;6057.727402266997;6151.876962460815;6188.195534580475;6226.439620434002;6234.127222188988;6240.219972503437;5834;6011.308699499438;6056.636601803906;6073.331933487225;6122 02:48:36 INFO - PROCESS | 9049 | |5;yui.html;787.7597332813493;816.0370762500255;817.9100298967113;877.9868301975471;901.6422056322718;15745.685086298266;16039.117848518326;16049.197540123005;16210;16668.083255420977;17227.310907563715;17277.91361043193;17519.38682146122;17532.912335438337;17683.027433491185;882.9558522073903;884.9646014159426;889.5552223888056;896.5203616065422;896.9955150224272;873.1399571422144;907.2469850024464;909.1408618855185;913.4793167894303;915.601713254733;941.9058094190594;948.3124734567452;948.3503799897093;949.8290307744603;950.2920324358363;931.0642803982023;934.6074648647584;936.8688383626297;939.6899023322321;947.0624082158682;687.7695971849437;694.4895501806168;695.1484431571336;695.183159787248;696.606417374182;16608.086555239457;16634.251458684266;16691.83308166915;16710.164491775362;16716.24776885043;15566.29951652167;15571.610709732235;15666.686666266725;15914.204289785464;15930.88483806134;12804.039697022761;12894.627820731024;12983.09118361715;13055.86944130556;13115.606531804062;4124.91750164998;4130.215259100762;4164.250434921743;4223.429836972;4223.493180818322;77455;78858;80624.59687701642;81101;82954.58522707348;12196.39018049094;12201.084918631139;12356.62930112098;12396.81404778929;12670.49318027287;23096.538069238857;23172.18897338585;23235.535289294457;23247.651285230735;23381;9157.725268241964;9216.493092879957;9360.765980850398;9516.619335226653;9544.61821527145;5111.463296353903;5198.194279886624;5246.973765131226;5273.077211488051;5313.123334649817;3780.2628487444686;3918.392649139388;3938.7439816411843;3945.4279129526058;3946.1121247719034;662.4435474201694;672.9024291477708;677.6036018928884;687.8693048320803;691.4226620771611;682.2836022176793;777.6383981448654;782.0576205672152;786.3669745854642;797.8165022044963;10497.527611257512;10507.947460262803;10513.632022879163;10675.25273230882;10795.622153224756;659.409828203755;768.8270139218743;804.3444592656966;816.5998660656236;826.1490664615455;4938.555530002317;4999;5113.642045056885;5141.408737995103;5177.508136727005;107746;117667.41166294114;119978.4001079989;122429;123754;41857.74426767202;64033.679831600544;68167;95636.52181739047;104577.47711261395;87215;88402.11597884068;88936.555317223;89489;89760;9619.134277915022;9679.08048735369;9703.708888733348;9776.21790256792;9895.059969302905;50290.748546258495;51257.48742512527;52104.47895520996;53237.467625323254;53783.92432151257;68836.6558167206;77044;77273;77471.61264193643;78226.21773782418;12397.318147501974;12410.503579857066;12459.750804983669;12579.119461637598;12943.482260709467;13279.406471223516;13574.796378054534;13657.931710341385;13760.724785504433;13766.380512876744;13162.736745265232;13446.663833404244;13622.86377136216;13890.722185556435;13899.444022239402;13274.867251327363;13399.397027133607;13599.796003059764;13607.727845443234;13875.236861972688;12861.678458038625;13046.282454465096;13485.123466974615;13534.526291579747;13847.584572462842;10607.363558186533;10700;10930.890691092987;10982.341059536453;11162.720931976766;11017.283876548;11164.720881978015;11263.155263355116;11337.546498139982;11418.771624567627 02:48:36 INFO - PROCESS | 9049 | __end_tp_report 02:48:36 INFO - PROCESS | 9049 | __start_cc_report 02:48:36 INFO - PROCESS | 9049 | _x_x_mozilla_cycle_collect,339 02:48:36 INFO - PROCESS | 9049 | __end_cc_report 02:48:36 INFO - PROCESS | 9049 | __startTimestamp1465292916590__endTimestamp 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | ------- Summary: start ------- 02:48:36 INFO - PROCESS | 9049 | Number of tests: 6 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#0] dojo.html Cycles:165 Average:5828.61 Median:6055.33 stddev:669.05 (11.0%) stddev-sans-first:642.69 02:48:36 INFO - PROCESS | 9049 | Values: 3369.6 3373.6 3420.9 3423.7 3441.0 5742.7 5836.0 5844.4 5862.7 5886.0 5881.9 5887.7 5904.2 5910.4 5926.2 5243.2 5351.5 5396.8 5398.0 5401.1 5284.0 5297.4 5425.2 5429.7 5446.5 5334.0 5366.9 5376.0 5401.0 5427.6 5283.1 5288.8 5372.6 5374.2 5384.1 5249.1 5300.6 5317.7 5362.2 5365.8 5548.7 5631.5 5674.5 5679.0 5724.9 6290.2 6299.5 6300.5 6310.7 6323.2 6118.2 6308.8 6357.3 6360.4 6364.0 5807.1 5838.8 5859.6 5902.3 5906.2 6360.7 6416.4 6429.8 6442.5 6447.4 5921.3 6049.9 6130.8 6172.5 6203.8 6114.9 6260.9 6263.7 6270.3 6277.3 6171.5 6215.6 6222.5 6224.0 6238.2 6099.1 6133.7 6150.4 6215.3 6216.1 4734.1 4747.3 4750.0 4759.9 4769.6 4230.7 4239.3 4240.7 4251.4 4254.3 5909.8 5970.8 5984.2 5993.7 6034.8 6064.0 6189.7 6256.5 6266.4 6346.1 6007.4 6039.4 6044.7 6045.4 6047.7 5249.1 5409.1 5444.4 5481.1 5520.0 6639.7 6657.0 6677.8 6682.3 6687.0 6122.7 6435.0 6462.2 6465.7 6467.1 6386.0 6408.1 6422.5 6507.6 6509.4 6233.4 6238.2 6239.8 6241.1 6246.9 6155.3 6190.7 6343.2 6360.7 6368.0 6040.1 6115.8 6148.1 6156.6 6185.1 6122.8 6158.5 6164.0 6182.5 6196.3 5813.9 5877.7 5916.5 6031.4 6070.7 6150.7 6179.0 6182.3 6200.6 6205.0 6055.3 6066.8 6070.0 6070.6 6089.5 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#1] ext.html Cycles:180 Average:63444.44 Median:42014.68 stddev:134163.96 (319.3%) stddev-sans-first:134457.34 02:48:36 INFO - PROCESS | 9049 | Values: 594.1 643.2 644.7 659.7 661.6 45462.5 46504.0 46685.5 51138.7 51204.7 47783.8 48421.3 48454.5 48548.0 48551.8 9074.5 9313.8 9320.6 9321.0 9324.0 9035.8 9126.3 9129.5 9143.3 9144.0 9156.9 9266.0 9267.1 9274.3 9282.7 9154.9 9157.5 9169.8 9187.4 9227.0 9169.6 9176.7 9201.8 9219.4 9275.5 45074.8 45342.3 45427.5 45502.5 45664.0 3752.5 3883.0 4013.1 4274.5 4581.7 34465.0 34598.1 34960.8 35108.6 35134.8 4532.9 4537.8 4606.1 4620.4 4631.7 397087.0 401031.0 401605.0 403945.0 404282.0 37654.2 60774.4 60775.7 61218.7 61800.7 38465.8 40191.4 40199.8 40201.2 40236.2 16187.2 16330.1 16340.8 16367.2 16406.5 13381.9 13518.5 13518.6 13524.6 13558.8 9284.8 9294.7 9298.3 9318.8 9357.8 3536.3 3568.1 3644.2 3649.7 3667.6 1073.3 1084.1 1085.6 1092.0 1161.9 32430.0 33529.0 33859.5 34029.0 34262.5 1129.6 1172.1 1187.9 1198.7 1283.8 17876.2 17895.0 17975.2 17996.6 18010.4 559554.0 559573.0 579878.0 579901.0 957055.0 61344.4 62064.0 62227.4 62361.0 62607.4 1382.5 1388.4 1392.1 1400.6 1420.3 32058.2 32239.7 32351.0 33120.7 33594.0 52512.0 52574.7 52652.0 52686.5 52866.0 385874.0 388043.0 388282.0 390662.0 390985.0 29608.7 30181.5 30252.5 30308.5 30444.1 49272.5 50738.5 50793.7 50885.0 51013.0 42161.6 42173.6 42651.0 43017.6 43955.6 39520.0 40562.0 40673.6 41526.6 41815.8 41112.8 41867.8 42177.4 42684.8 42904.8 36863.4 37031.4 37254.3 37702.6 38172.8 28466.9 28575.3 28645.7 28771.7 28818.0 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#2] jquery.html Cycles:180 Average:30021.75 Median:13059.22 stddev:85142.76 (652.0%) stddev-sans-first:85352.62 02:48:36 INFO - PROCESS | 9049 | Values: 432.6 434.7 435.2 437.6 444.8 18514.4 19613.7 20322.9 20508.1 20541.5 19562.4 20224.9 20356.0 21250.0 21285.6 5602.7 5712.7 5722.1 5754.0 5774.4 5787.2 5859.1 5935.9 5948.4 5994.6 5775.0 5842.0 5868.7 5876.6 5880.8 5745.0 5845.9 5867.2 5903.7 5920.5 5281.3 5300.1 5305.7 5307.2 5317.2 23687.9 24300.4 24484.1 24519.0 24557.6 2358.0 2430.6 2447.1 2822.7 2836.7 14514.9 14996.9 15253.1 15269.9 15453.0 2038.4 2061.1 2071.6 2142.7 2178.3 82175.6 82520.6 82548.0 83159.2 83975.0 11091.1 11219.2 11450.7 11827.6 12020.8 15727.2 15826.1 15846.0 15857.9 15948.3 8722.9 8734.8 8885.7 8911.0 8958.9 8282.3 8387.7 8570.7 8615.4 8626.9 7015.2 7129.4 7131.5 7137.7 7162.9 2056.7 2058.2 2058.6 2118.9 2126.1 944.3 1029.8 1086.3 1138.0 1142.3 20068.6 20348.9 20453.7 20613.9 20948.7 1059.4 1063.5 1067.3 1095.2 1131.9 11814.8 11881.5 11881.6 12075.5 12110.6 503937.0 517733.0 522347.0 523145.0 529906.0 68717.7 77079.6 77123.0 83434.2 86955.6 1093.9 1095.3 1105.0 1131.4 1132.4 18307.4 18576.0 18613.4 18693.6 18886.0 39521.2 39571.0 41015.6 41023.6 41600.4 53901.5 55190.2 55600.0 55778.4 56213.2 9037.6 9136.4 9185.3 9226.1 9466.9 14010.4 14294.9 14355.9 14360.3 14436.7 10226.2 11921.0 12605.6 12640.8 12719.3 11937.8 12137.8 12333.1 12504.0 12679.6 10756.1 12779.4 12843.0 12855.9 13002.7 8806.8 8935.5 9158.4 9190.6 9309.9 12626.6 12659.6 12834.2 12877.5 12879.0 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#3] mootools.html Cycles:180 Average:6433.21 Median:4715.46 stddev:3764.77 (79.8%) stddev-sans-first:3757.80 02:48:36 INFO - PROCESS | 9049 | Values: 1598.6 1624.2 1875.1 1909.6 1949.3 8533.2 9367.4 9391.2 10034.4 10067.2 9081.3 9385.2 9403.8 9441.6 9506.0 2481.3 2487.2 2496.2 2498.0 2507.5 2450.5 2487.1 2507.2 2507.4 2510.1 2518.7 2527.0 2553.5 2559.9 2566.9 2428.3 2461.1 2475.5 2492.9 2497.5 2476.3 2485.6 2513.2 2544.0 2551.5 9681.3 9713.9 9716.2 9745.0 9760.8 5773.9 5774.3 5809.4 5838.3 5841.6 3659.2 3724.6 3805.9 3829.1 3868.4 1186.7 1197.1 1214.0 1214.2 1219.4 14252.1 14262.1 14300.6 14306.4 14359.1 4908.4 4996.2 5006.7 5079.4 5143.9 11623.8 11629.7 11839.1 12078.0 12174.9 5919.1 5956.1 5958.4 5970.7 5983.9 4681.8 5221.8 5229.8 5337.8 5481.9 4388.0 4394.3 4459.9 4465.3 4511.6 1341.7 1365.5 1373.4 1381.8 1385.7 911.4 940.8 1034.7 1042.8 1081.6 6551.3 6551.8 6600.4 6634.3 6778.4 455.3 457.2 459.5 499.6 503.2 4674.1 4698.7 4732.2 4812.6 4842.3 12028.8 12210.1 12464.3 12539.6 12546.3 12034.8 12252.6 12366.3 12439.4 12444.8 9106.9 9164.6 9247.6 9250.3 9308.8 6695.6 6698.0 6704.2 6704.6 6806.4 11222.0 11338.5 11409.3 11427.5 11489.1 11379.5 11579.1 11603.2 11641.2 11684.9 7645.5 8197.1 8353.9 8759.8 8791.1 9407.1 9422.8 9478.7 9503.7 9512.2 8215.3 8470.5 8496.9 8514.4 8590.4 8130.1 8367.6 8422.8 8493.3 8553.5 7432.1 7520.7 7538.8 7548.5 7567.1 5330.5 5596.8 5610.5 5676.3 5796.2 5488.9 5519.2 5544.9 5623.7 5711.8 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#4] prototype.html Cycles:180 Average:5123.34 Median:5726.37 stddev:1516.09 (26.5%) stddev-sans-first:1477.51 02:48:36 INFO - PROCESS | 9049 | Values: 356.0 358.4 359.1 364.3 367.5 5787.9 5859.5 5863.7 5867.6 5929.2 5602.8 5798.4 5801.2 5835.3 5848.8 4501.9 4539.9 4546.1 4561.7 4576.8 4580.2 4583.5 4586.0 4592.3 4613.4 4537.7 4578.2 4585.7 4597.4 4601.8 4189.3 4478.1 4485.1 4493.6 4510.2 3962.7 3982.5 3986.2 3992.6 3995.8 5584.8 5594.9 5606.9 5615.4 5632.5 5063.0 5150.7 5181.9 5215.7 5221.6 6054.9 6124.8 6130.8 6145.0 6160.0 4212.5 4348.5 4387.4 4406.4 4417.2 6167.9 6264.5 6314.9 6333.8 6358.6 4429.2 4438.1 4446.5 4452.9 4475.6 4501.1 4536.7 4537.8 4552.2 4559.1 4949.2 5127.2 5127.9 5141.2 5179.2 6164.8 6178.6 6183.9 6189.8 6199.4 1525.1 1553.0 1556.9 1565.9 1569.0 962.0 982.8 985.5 1001.7 1010.0 5273.0 5288.9 5302.5 5318.9 5334.4 5532.1 5561.8 5594.7 5637.0 5664.8 5335.6 5392.2 5526.8 6013.8 6025.9 3377.7 3399.7 3403.9 3425.3 3432.1 6214.3 6541.2 6591.6 6603.5 6668.9 6448.8 6474.7 6500.8 6518.8 6523.0 6295.1 6534.3 6582.6 6605.3 6622.2 6310.4 6319.4 6338.0 6355.5 6363.8 5956.7 6290.7 6296.7 6309.0 6327.5 6498.8 6537.7 6543.6 6554.9 6572.7 4410.9 4468.9 4469.8 4484.6 4499.0 6254.7 6323.3 6341.6 6341.9 6493.0 6120.9 6134.0 6162.9 6163.3 6176.3 5915.8 6106.1 6110.2 6151.7 6191.7 5990.9 6010.5 6049.7 6056.0 6057.7 6151.9 6188.2 6226.4 6234.1 6240.2 5834.0 6011.3 6056.6 6073.3 6122.0 02:48:36 INFO - PROCESS | 9049 | 02:48:36 INFO - PROCESS | 9049 | [#5] yui.html Cycles:180 Average:20802.43 Median:4223.46 stddev:29345.25 (694.8%) stddev-sans-first:29389.09 02:48:36 INFO - PROCESS | 9049 | Values: 787.8 816.0 817.9 878.0 901.6 15745.7 16039.1 16049.2 16210.0 16668.1 17227.3 17277.9 17519.4 17532.9 17683.0 883.0 885.0 889.6 896.5 897.0 873.1 907.2 909.1 913.5 915.6 941.9 948.3 948.4 949.8 950.3 931.1 934.6 936.9 939.7 947.1 687.8 694.5 695.1 695.2 696.6 16608.1 16634.3 16691.8 16710.2 16716.2 15566.3 15571.6 15666.7 15914.2 15930.9 12804.0 12894.6 12983.1 13055.9 13115.6 4124.9 4130.2 4164.3 4223.4 4223.5 77455.0 78858.0 80624.6 81101.0 82954.6 12196.4 12201.1 12356.6 12396.8 12670.5 23096.5 23172.2 23235.5 23247.7 23381.0 9157.7 9216.5 9360.8 9516.6 9544.6 5111.5 5198.2 5247.0 5273.1 5313.1 3780.3 3918.4 3938.7 3945.4 3946.1 662.4 672.9 677.6 687.9 691.4 682.3 777.6 782.1 786.4 797.8 10497.5 10507.9 10513.6 10675.3 10795.6 659.4 768.8 804.3 816.6 826.1 4938.6 4999.0 5113.6 5141.4 5177.5 107746.0 117667.4 119978.4 122429.0 123754.0 41857.7 64033.7 68167.0 95636.5 104577.5 87215.0 88402.1 88936.6 89489.0 89760.0 9619.1 9679.1 9703.7 9776.2 9895.1 50290.7 51257.5 52104.5 53237.5 53783.9 68836.7 77044.0 77273.0 77471.6 78226.2 12397.3 12410.5 12459.8 12579.1 12943.5 13279.4 13574.8 13657.9 13760.7 13766.4 13162.7 13446.7 13622.9 13890.7 13899.4 13274.9 13399.4 13599.8 13607.7 13875.2 12861.7 13046.3 13485.1 13534.5 13847.6 10607.4 10700.0 10930.9 10982.3 11162.7 11017.3 11164.7 11263.2 11337.5 11418.8 02:48:36 INFO - PROCESS | 9049 | -------- Summary: end -------- 02:48:36 INFO - PROCESS | 9049 | 02:48:37 INFO - TEST-INFO | 9049: exit 0 02:48:37 INFO - TEST-OK | dromaeo_css | took 1110485ms 02:48:37 INFO - TEST-START | kraken 02:48:37 INFO - operating with platform_type : linux_ 02:48:37 INFO - Initialising browser for kraken test... 02:48:37 INFO - TEST-INFO | started process 9291 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_LEGBA/profile http://localhost:57206/getInfo.html) 02:48:41 INFO - PROCESS | 9291 | __metrics Screen width/height:1600/1200 02:48:41 INFO - PROCESS | 9291 | colorDepth:24 02:48:41 INFO - PROCESS | 9291 | Browser inner width/height: 1024/697 02:48:41 INFO - PROCESS | 9291 | __metrics 02:48:42 ERROR - PROCESS | 9291 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2944: TypeError: this.tabs is undefined 02:48:43 INFO - TEST-INFO | 9291: exit 0 02:48:43 INFO - Browser initialized. 02:48:43 INFO - Running cycle 1/1 for kraken test... 02:48:43 INFO - TEST-INFO | started process 9419 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_LEGBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:48:55 INFO - PROCESS | 9419 | RSS: Main: 156372992 02:48:55 INFO - PROCESS | 9419 | 02:48:57 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57206/tests/kraken/driver.html?testName=audio-beat-detection) 02:48:58 INFO - PROCESS | 9419 | RSS: Main: 161361920 02:48:58 INFO - PROCESS | 9419 | 02:49:01 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57206/tests/kraken/driver.html?testName=audio-dft) 02:49:01 INFO - PROCESS | 9419 | RSS: Main: 160489472 02:49:01 INFO - PROCESS | 9419 | 02:49:04 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57206/tests/kraken/driver.html?testName=audio-fft) 02:49:05 INFO - PROCESS | 9419 | RSS: Main: 161599488 02:49:05 INFO - PROCESS | 9419 | 02:49:07 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57206/tests/kraken/driver.html?testName=audio-oscillator) 02:49:08 INFO - PROCESS | 9419 | RSS: Main: 160907264 02:49:08 INFO - PROCESS | 9419 | 02:49:10 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57206/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:49:10 INFO - PROCESS | 9419 | RSS: Main: 161251328 02:49:10 INFO - PROCESS | 9419 | 02:49:14 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57206/tests/kraken/driver.html?testName=imaging-darkroom) 02:49:14 INFO - PROCESS | 9419 | RSS: Main: 160768000 02:49:14 INFO - PROCESS | 9419 | 02:49:18 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57206/tests/kraken/driver.html?testName=imaging-desaturate) 02:49:18 INFO - PROCESS | 9419 | RSS: Main: 161239040 02:49:18 INFO - PROCESS | 9419 | 02:49:21 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57206/tests/kraken/driver.html?testName=json-parse-financial) 02:49:22 INFO - PROCESS | 9419 | RSS: Main: 160608256 02:49:22 INFO - PROCESS | 9419 | 02:49:23 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57206/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:49:24 INFO - PROCESS | 9419 | RSS: Main: 160370688 02:49:24 INFO - PROCESS | 9419 | 02:49:25 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:49:26 INFO - PROCESS | 9419 | RSS: Main: 160669696 02:49:26 INFO - PROCESS | 9419 | 02:49:28 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:49:29 INFO - PROCESS | 9419 | RSS: Main: 161427456 02:49:29 INFO - PROCESS | 9419 | 02:49:31 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:49:32 INFO - PROCESS | 9419 | RSS: Main: 161988608 02:49:32 INFO - PROCESS | 9419 | 02:49:35 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:49:35 INFO - PROCESS | 9419 | RSS: Main: 161591296 02:49:35 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | Cycle 1(1): loaded http://localhost:57206/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57206/tests/kraken/driver.html?testName=ai-astar) 02:49:37 INFO - PROCESS | 9419 | RSS: Main: 162164736 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | __start_tp_report 02:49:37 INFO - PROCESS | 9419 | _x_x_mozilla_page_load 02:49:37 INFO - PROCESS | 9419 | _x_x_mozilla_page_load_details 02:49:37 INFO - PROCESS | 9419 | |i|pagename|runs| 02:49:37 INFO - PROCESS | 9419 | |0;ai-astar;110;106;112;110;111;112;111;110;111;112 02:49:37 INFO - PROCESS | 9419 | |1;audio-beat-detection;154;125;159;176;128;158;165;128;199;131 02:49:37 INFO - PROCESS | 9419 | |2;audio-dft;165;163;163;162;161;164;163;164;165;162 02:49:37 INFO - PROCESS | 9419 | |3;audio-fft;75;75;75;175;76;76;77;75;161;75 02:49:37 INFO - PROCESS | 9419 | |4;audio-oscillator;83;86;148;84;88;85;139;85;85;144 02:49:37 INFO - PROCESS | 9419 | |5;imaging-gaussian-blur;121;119;117;117;117;118;117;117;119;118 02:49:37 INFO - PROCESS | 9419 | |6;imaging-darkroom;147;148;147;146;148;149;147;148;147;150 02:49:37 INFO - PROCESS | 9419 | |7;imaging-desaturate;95;95;96;96;96;95;95;96;94;96 02:49:37 INFO - PROCESS | 9419 | |8;json-parse-financial;52;52;53;53;52;58;54;55;52;53 02:49:37 INFO - PROCESS | 9419 | |9;json-stringify-tinderbox;60;60;59;60;60;60;60;60;61;60 02:49:37 INFO - PROCESS | 9419 | |10;stanford-crypto-aes;81;76;74;78;77;77;80;78;104;76 02:49:37 INFO - PROCESS | 9419 | |11;stanford-crypto-ccm;122;121;119;125;120;131;119;125;122;127 02:49:37 INFO - PROCESS | 9419 | |12;stanford-crypto-pbkdf2;158;153;155;152;153;158;167;153;159;158 02:49:37 INFO - PROCESS | 9419 | |13;stanford-crypto-sha256-iterative;63;64;65;62;66;61;62;62;61;62 02:49:37 INFO - PROCESS | 9419 | __end_tp_report 02:49:37 INFO - PROCESS | 9419 | __start_cc_report 02:49:37 INFO - PROCESS | 9419 | _x_x_mozilla_cycle_collect,865 02:49:37 INFO - PROCESS | 9419 | __end_cc_report 02:49:37 INFO - PROCESS | 9419 | __startTimestamp1465292977669__endTimestamp 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | ------- Summary: start ------- 02:49:37 INFO - PROCESS | 9419 | Number of tests: 14 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.78 (1.6%) stddev-sans-first:1.88 02:49:37 INFO - PROCESS | 9419 | Values: 110.0 106.0 112.0 110.0 111.0 112.0 111.0 110.0 111.0 112.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#1] audio-beat-detection Cycles:10 Average:152.30 Median:158.50 stddev:24.41 (15.4%) stddev-sans-first:25.89 02:49:37 INFO - PROCESS | 9419 | Values: 154.0 125.0 159.0 176.0 128.0 158.0 165.0 128.0 199.0 131.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#2] audio-dft Cycles:10 Average:163.20 Median:163.50 stddev:1.32 (0.8%) stddev-sans-first:1.22 02:49:37 INFO - PROCESS | 9419 | Values: 165.0 163.0 163.0 162.0 161.0 164.0 163.0 164.0 165.0 162.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#3] audio-fft Cycles:10 Average:94.00 Median:75.00 stddev:39.15 (52.2%) stddev-sans-first:40.91 02:49:37 INFO - PROCESS | 9419 | Values: 75.0 75.0 75.0 175.0 76.0 76.0 77.0 75.0 161.0 75.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#4] audio-oscillator Cycles:10 Average:102.70 Median:85.00 stddev:28.38 (33.4%) stddev-sans-first:29.19 02:49:37 INFO - PROCESS | 9419 | Values: 83.0 86.0 148.0 84.0 88.0 85.0 139.0 85.0 85.0 144.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#5] imaging-gaussian-blur Cycles:10 Average:118.00 Median:118.00 stddev:1.33 (1.1%) stddev-sans-first:0.87 02:49:37 INFO - PROCESS | 9419 | Values: 121.0 119.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 118.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:1.16 (0.8%) stddev-sans-first:1.20 02:49:37 INFO - PROCESS | 9419 | Values: 147.0 148.0 147.0 146.0 148.0 149.0 147.0 148.0 147.0 150.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#7] imaging-desaturate Cycles:10 Average:95.40 Median:96.00 stddev:0.70 (0.7%) stddev-sans-first:0.73 02:49:37 INFO - PROCESS | 9419 | Values: 95.0 95.0 96.0 96.0 96.0 95.0 95.0 96.0 94.0 96.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#8] json-parse-financial Cycles:10 Average:53.40 Median:53.00 stddev:1.90 (3.6%) stddev-sans-first:1.94 02:49:37 INFO - PROCESS | 9419 | Values: 52.0 52.0 53.0 53.0 52.0 58.0 54.0 55.0 52.0 53.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#9] json-stringify-tinderbox Cycles:10 Average:60.00 Median:60.00 stddev:0.47 (0.8%) stddev-sans-first:0.50 02:49:37 INFO - PROCESS | 9419 | Values: 60.0 60.0 59.0 60.0 60.0 60.0 60.0 60.0 61.0 60.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#10] stanford-crypto-aes Cycles:10 Average:80.10 Median:77.50 stddev:8.63 (11.1%) stddev-sans-first:9.15 02:49:37 INFO - PROCESS | 9419 | Values: 81.0 76.0 74.0 78.0 77.0 77.0 80.0 78.0 104.0 76.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:123.50 stddev:3.87 (3.1%) stddev-sans-first:4.09 02:49:37 INFO - PROCESS | 9419 | Values: 122.0 121.0 119.0 125.0 120.0 131.0 119.0 125.0 122.0 127.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:156.60 Median:158.00 stddev:4.50 (2.8%) stddev-sans-first:4.75 02:49:37 INFO - PROCESS | 9419 | Values: 158.0 153.0 155.0 152.0 153.0 158.0 167.0 153.0 159.0 158.0 02:49:37 INFO - PROCESS | 9419 | 02:49:37 INFO - PROCESS | 9419 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.80 Median:62.50 stddev:1.69 (2.7%) stddev-sans-first:1.79 02:49:37 INFO - PROCESS | 9419 | Values: 63.0 64.0 65.0 62.0 66.0 61.0 62.0 62.0 61.0 62.0 02:49:37 INFO - PROCESS | 9419 | -------- Summary: end -------- 02:49:37 INFO - PROCESS | 9419 | 02:49:38 INFO - TEST-INFO | 9419: exit 0 02:49:38 INFO - TEST-OK | kraken | took 61376ms 02:49:38 INFO - SUITE-END | took 1171s 02:49:38 INFO - Completed test suite (00:19:32) 02:49:38 INFO - javascript benchmark 02:49:38 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7711.0463020476345, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3369.6461871503475, 3373.5951685797704, 3420.914477138073, 3423.657634236576, 3441.0021093882774, 5742.655440673562, 5835.970820145904, 5844.444777746118, 5862.706864656766, 5885.970570147154, 5881.941180588193, 5887.735051922663, 5904.202932604097, 5910.379410161925, 5926.199963004993, 5243.213517972306, 5351.518363347298, 5396.784128634869, 5397.973010134944, 5401.108817045183, 5284.0, 5297.417284098746, 5425.240466334716, 5429.728513574325, 5446.537044351235, 5334.0, 5366.8926621467745, 5376.0, 5401.027814993299, 5427.6472029318165, 5283.075461794209, 5288.788448462057, 5372.597055220874, 5374.167004114369, 5384.138537833967, 5249.081410753103, 5300.628955973083, 5317.707526086064, 5362.249285100089, 5365.839024829262, 5548.667079975174, 5631.549476041907, 5674.460926212003, 5679.034564124109, 5724.856878578069, 6290.182276304097, 6299.496040316763, 6300.464460520861, 6310.684465776692, 6323.241211054703, 6118.162361256266, 6308.810735677937, 6357.332480089616, 6360.427561519439, 6363.96818015907, 5807.128930660392, 5838.795642152504, 5859.648421094748, 5902.2622172228475, 5906.232189815297, 6360.681965901779, 6416.358364163546, 6429.839254018687, 6442.484601231984, 6447.3552644735155, 5921.259842519685, 6049.879002419927, 6130.816075517741, 6172.475339596184, 6203.844903877439, 6114.875284800388, 6260.874782504325, 6263.655498947511, 6270.31026587075, 6277.278113016971, 6171.537134714914, 6215.627062376272, 6222.471089957314, 6224.035274532454, 6238.157848690369, 6099.054646529795, 6133.701927635063, 6150.384961503813, 6215.285242197205, 6216.129741836146, 4734.053189362073, 4747.2879068140055, 4750.0, 4759.928601070987, 4769.642276829251, 4230.682698797603, 4239.258129827268, 4240.660747140221, 4251.44731184944, 4254.276772948606, 5909.763609455659, 5970.820875373745, 5984.222051133324, 5993.700314984233, 6034.818955431344, 6063.969680151659, 6189.690515474208, 6256.499480041586, 6266.373362663789, 6346.143270658495, 6007.429294217042, 6039.365866584033, 6044.727987240584, 6045.395460453919, 6047.7278522466595, 5249.107651699221, 5409.053415652324, 5444.373897001817, 5481.123020316731, 5519.972400138054, 6639.668016599151, 6657.034729964128, 6677.799666010027, 6682.264950855402, 6686.966565167143, 6122.693865306628, 6434.967825160844, 6462.192225971754, 6465.709043093166, 6467.062275970052, 6385.968070159805, 6408.102865598727, 6422.518311126591, 6507.577007494498, 6509.381608747161, 6233.376662333731, 6238.189035425366, 6239.7504099837315, 6241.063840423973, 6246.875062498633, 6155.2613686356135, 6190.7214175363115, 6343.207099112611, 6360.650164241011, 6368.0, 6040.063790112539, 6115.755369785159, 6148.077788331786, 6156.630602163885, 6185.103160041859, 6122.846928826637, 6158.507319414526, 6164.0, 6182.474489668429, 6196.349383314687, 5813.94186058134, 5877.706114694162, 5916.49709774674, 6031.396860313934, 6070.666113363807, 6150.692465376803, 6179.0, 6182.28903676083, 6200.596961197508, 6204.968975155095, 6055.333913269449, 6066.787662431793, 6070.0, 6070.586362324697, 6089.451949324405], "value": 5783.121483303366, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [594.1147689941988, 643.1510406263732, 644.7259914536321, 659.6833519910446, 661.6394065234448, 45462.545374546244, 46504.0, 46685.533144668545, 51138.74430627851, 51204.74397628016, 47783.76108119463, 48421.27368089482, 48454.51545484544, 48548.02903941928, 48551.757241213745, 9074.500902450363, 9313.813723725521, 9320.62717491303, 9321.0, 9324.0, 9035.819283614324, 9126.26989840811, 9129.45223286605, 9143.314251431137, 9144.0, 9156.908430915706, 9266.0, 9267.119623635745, 9274.304427167956, 9282.675106371278, 9154.908450915505, 9157.542122893828, 9169.770755731093, 9187.402818816823, 9227.031161728022, 9169.633214671405, 9176.724698259062, 9201.815963680756, 9219.400738952014, 9275.489848058354, 45074.77462612666, 45342.31986520205, 45427.54572454299, 45502.544974550496, 45664.0, 3752.5309336332957, 3883.0486530799853, 4013.097053163044, 4274.487061552633, 4581.725096494221, 34465.0, 34598.135046623785, 34960.825195873855, 35108.64891351079, 35134.82432587821, 4532.864014079583, 4537.750423726694, 4606.147862645421, 4620.399348084761, 4631.698939568917, 397087.0145649282, 401031.0, 401605.0, 403945.0, 404282.0, 37654.24691506154, 60774.39225607687, 60775.69612151911, 61218.69390653107, 61800.69099654563, 38465.80767096147, 40191.397129043085, 40199.79900100539, 40201.195976080315, 40236.19527609432, 16187.19064046793, 16330.101844398434, 16340.75488867668, 16367.181640917906, 16406.507804765875, 13381.933090334485, 13518.459261629621, 13518.59444216675, 13524.59426217215, 13558.796618050737, 9284.814303713887, 9294.721158365124, 9298.349115561981, 9318.767030824283, 9357.812843743088, 3536.310419468179, 3568.0901370150445, 3644.1982763791925, 3649.7445178837756, 3667.624640759715, 1073.2862646340097, 1084.1272775415866, 1085.5603480590373, 1091.9945400272948, 1161.9302841829517, 32430.0, 33529.0, 33859.492107618404, 34029.0, 34262.48606270908, 1129.5989923577176, 1172.1091970102614, 1187.8812118788053, 1198.6943329451108, 1283.7560863435917, 17876.19557119933, 17895.0, 17975.191116399794, 17996.640067198583, 18010.36963706264, 559554.0, 559573.0, 579878.0, 579901.0, 957055.0, 61344.38655613476, 62064.0, 62227.377726222156, 62361.0, 62607.37392626107, 1382.4953891829612, 1388.3891087921281, 1392.088182240634, 1400.5798260521804, 1420.254366457618, 32058.19854503656, 32239.677603223667, 32351.0, 33120.66879331176, 33593.99218023463, 52512.0, 52574.737126314125, 52652.0, 52686.47313526969, 52866.0, 385874.0, 388043.0, 388282.0, 390662.0, 390985.0, 29608.703912960595, 30181.547276790425, 30252.5462118064, 30308.545371819, 30444.086677399715, 49272.50727492679, 50738.49261507337, 50793.746031269606, 50885.0, 51013.0, 42161.57838421576, 42173.578264216965, 42651.0, 43017.569824302605, 43955.560444395145, 39520.0, 40562.0, 40673.59326406698, 41526.584734152275, 41815.7909210452, 41112.794436028824, 41867.7906610465, 42177.36733948932, 42684.78657606692, 42904.78547607242, 36863.44704829376, 37031.44452833156, 37254.25491490209, 37702.62297377101, 38172.80913595414, 28466.857665711537, 28575.28561785972, 28645.713542864305, 28771.71228287774, 28818.0], "value": 20015.996704773723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.59552318582126, 434.65662126919733, 435.22456995667494, 437.58648077566704, 444.7576071041282, 18514.444566663005, 19613.705794413076, 20322.89838550807, 20508.077136528856, 20541.4864628384, 19562.41312760616, 20224.898875505638, 20355.999999999964, 21250.0, 21285.57428851422, 5602.663840169593, 5712.685802280873, 5722.113072473773, 5753.971230143864, 5774.364819869811, 5787.189793428924, 5859.091840764689, 5935.910961335583, 5948.375420580842, 5994.610350327237, 5775.047117225653, 5842.0, 5868.706564671771, 5876.588638795286, 5880.794172203974, 5744.999999999979, 5845.85385365365, 5867.178594996704, 5903.704814759245, 5920.467157955762, 5281.287026251445, 5300.072487314743, 5305.734713264322, 5307.177387504904, 5317.229001794757, 23687.881560592086, 24300.39249018771, 24484.14305499317, 24519.0, 24557.631635525482, 2357.951853495778, 2430.562498750224, 2447.1312683997103, 2822.7459528642316, 2836.6879643239226, 14514.927425362912, 14996.925015374962, 15253.08481491114, 15269.923650381677, 15453.0, 2038.398672391648, 2061.072517367191, 2071.5856828634332, 2142.721446211998, 2178.2920550821045, 82175.589122054, 82520.58739706322, 82548.0, 83159.16840831575, 83975.0, 11091.112710983101, 11219.214654974237, 11450.656480305604, 11827.586034488751, 12020.759584808255, 15727.213639317988, 15826.129562874152, 15846.0, 15857.920710396374, 15948.2823272953, 8722.86915696265, 8734.825303493895, 8885.733427997171, 8911.0, 8958.86561701575, 8282.296004839536, 8387.706430274911, 8570.700025499078, 8615.439996400213, 8626.870596941051, 7015.158181018209, 7129.394001509826, 7131.536450130829, 7137.715211262022, 7162.892556611655, 2056.6812144117685, 2058.1664425907234, 2058.6294466996083, 2118.9364319070146, 2126.064531606088, 944.254039308952, 1029.7580068683853, 1086.3264775838873, 1137.954481820718, 1142.257532603814, 20068.598628027357, 20348.89825550863, 20453.693194602092, 20613.896930515253, 20948.743075415525, 1059.3685723985132, 1063.5161001744189, 1067.290251982423, 1095.1567293184203, 1131.9264247823864, 11814.822777658343, 11881.465334059989, 11881.5841445549, 12075.45660445282, 12110.576129835414, 503937.0, 517733.0, 522347.0, 523145.0, 529906.0, 68717.65641171762, 77079.61460192663, 77122.99999999888, 83434.16565834386, 86955.56522217348, 1093.912487001038, 1095.2606990281529, 1105.0220554809052, 1131.4116659337262, 1132.445101900063, 18307.35924242645, 18576.0, 18613.44159675212, 18693.626127477102, 18886.0, 39521.20957580775, 39571.01072473096, 41015.58984410237, 41023.58976410198, 41600.37599435951, 53901.46098539121, 55190.17214741702, 55600.0, 55778.44221557733, 56213.15680264717, 9037.593308301273, 9136.406133601295, 9185.265178785814, 9226.123518265755, 9466.905330946602, 14010.369533371226, 14294.928525357307, 14355.928220358832, 14360.281985900872, 14436.711265774416, 10226.181905447695, 11921.0, 12605.621831344708, 12640.828526586021, 12719.300438475973, 11937.761244775229, 12137.817932730839, 12333.136680432284, 12504.0, 12679.556215532411, 10756.117679405916, 12779.36103194855, 12843.0, 12855.87144128584, 13002.674933126747, 8806.779830504032, 8935.463872167691, 9158.40470369424, 9190.58642361082, 9309.906900931175, 12626.55807046749, 12659.620211393672, 12834.229946203257, 12877.484900603871, 12879.0], "value": 9838.75709069922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1598.5603958911302, 1624.204139971414, 1875.1374367790816, 1909.6085302512986, 1949.2787668562626, 8533.232009119178, 9367.437953722781, 9391.201747851432, 10034.448105354202, 10067.194624430056, 9081.318901082428, 9385.249180065595, 9403.811923761521, 9441.575129119188, 9506.0, 2481.305234534329, 2487.2413913756295, 2496.2386472125995, 2497.9750202498017, 2507.4608959073794, 2450.4608986023136, 2487.1046423287694, 2507.2352932355625, 2507.4232926426935, 2510.0587279770084, 2518.7229404765462, 2527.027094568595, 2553.540362734707, 2559.8976040958432, 2566.8973241070335, 2428.295794219674, 2461.064795377754, 2475.5296493666237, 2492.9002839886384, 2497.4880149569294, 2476.2818782553036, 2485.63958226058, 2513.246026192135, 2544.0459827564664, 2551.4769472258145, 9681.273904457123, 9713.90286097144, 9716.174125199366, 9745.0, 9760.755981100458, 5773.88452230953, 5774.307083150007, 5809.3609702932645, 5838.328592211908, 5841.620294680833, 3659.1949771050326, 3724.5902950675404, 3805.9429108563395, 3829.1384438501113, 3868.355948721782, 1186.7151883547972, 1197.0902114393036, 1214.0287769784225, 1214.168294718121, 1219.378117160246, 14252.073615215082, 14262.144271343648, 14300.642483937776, 14306.356213970397, 14359.138451692932, 4908.361912951294, 4996.225585034325, 5006.74966251686, 5079.4412614612365, 5143.922841157386, 11623.76752464946, 11629.651110466699, 11839.11206659504, 12078.0, 12174.939125304494, 5919.112133179971, 5956.1065840123465, 5958.433948774859, 5970.731317090655, 5983.910241346383, 4681.789319480631, 5221.843344699665, 5229.79714665629, 5337.8131765388025, 5481.917771233435, 4388.0, 4394.318880573516, 4459.910801783946, 4465.285554311295, 4511.571400716926, 1341.6511706956067, 1365.5220672764651, 1373.4300265389952, 1381.7789153735355, 1385.7020740540831, 911.4166933162782, 940.7977284883783, 1034.6947650443137, 1042.817506936283, 1081.6484642491064, 6551.344865513411, 6551.80344589663, 6600.405963463311, 6634.270230274666, 6778.423833974168, 455.29429384453965, 457.2295681776218, 459.4922610515399, 499.59532778449574, 503.2174967924912, 4674.11191873543, 4698.741569213657, 4732.1718699227495, 4812.5668689818085, 4842.273658951115, 12028.759424811455, 12210.145289829805, 12464.252144871336, 12539.623811285675, 12546.309952952493, 12034.75930481403, 12252.632421027205, 12366.319852408024, 12439.440225189706, 12444.81332780009, 9106.908930910871, 9164.587593558306, 9247.583858726373, 9250.306227033, 9308.767280818034, 6695.598264104169, 6697.966510167613, 6704.195496540447, 6704.597724136567, 6806.353396427331, 11222.046126079049, 11338.546458141582, 11409.25839820409, 11427.485763140512, 11489.080873530265, 11379.487923043318, 11579.073674105883, 11603.245789023686, 11641.243319184226, 11684.88315116838, 7645.503042302233, 8197.057338406159, 8353.916460835313, 8759.781005474913, 8791.120887911158, 9407.059294070812, 9422.764430889009, 9478.715638530855, 9503.66737164196, 9512.23902087845, 8215.260626543639, 8470.49177049379, 8496.915030849612, 8514.403991720521, 8590.398672092893, 8130.065042520186, 8367.623456944573, 8422.83154336922, 8493.278071364004, 8553.529555874487, 7432.070991126109, 7520.661570229462, 7538.849223015619, 7548.4716069874585, 7567.091948966159, 5330.520253177233, 5596.832095037155, 5610.5231055360755, 5676.34722006958, 5796.21751063601, 5488.862778430412, 5519.227308176778, 5544.861378465571, 5623.746931388179, 5711.771529138788], "value": 5012.179108956636, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.95372601561803, 358.4157822748919, 359.12911190363394, 364.2750925657941, 367.53873888270215, 5787.913181302284, 5859.531237501001, 5863.736131874065, 5867.647941123536, 5929.229200203968, 5602.803901863435, 5798.42015798421, 5801.216835727176, 5835.299764028312, 5848.795292164775, 4501.932471012938, 4539.886502837422, 4546.113507865967, 4561.657875659323, 4576.794044267999, 4580.175568397687, 4583.472900616422, 4585.9541404586025, 4592.2905485763395, 4613.423322084739, 4537.659675524333, 4578.153041687282, 4585.679002469828, 4597.4483062032605, 4601.792919318638, 4189.329707246841, 4478.126765280772, 4485.147821913826, 4493.5506449355125, 4510.233260345733, 3962.7424217425773, 3982.5021872265966, 3986.202759448122, 3992.5608183099835, 3995.820188091543, 5584.776608935637, 5594.916076258859, 5606.943930560724, 5615.354234263031, 5632.549396048347, 5062.974685126551, 5150.712321919483, 5181.922271165936, 5215.6609820361555, 5221.582273418117, 6054.878902421927, 6124.785632502885, 6130.754769809247, 6145.047517634774, 6160.02879078695, 4212.49450065991, 4348.4999225089205, 4387.407699960497, 4406.383106365111, 4417.160739459525, 6167.907481387782, 6264.498840092781, 6314.905276420857, 6333.8416539586415, 6358.58669186506, 4429.2027435062, 4438.134563760036, 4446.5331140230455, 4452.888677783017, 4475.597196252288, 4501.122281155209, 4536.72779633223, 4537.8184872604725, 4552.1806074906835, 4559.1307563898645, 4949.183384741549, 5127.154019586801, 5127.923136141378, 5141.151709967889, 5179.171332586768, 6164.815055548341, 6178.598391104564, 6183.876322473526, 6189.783357582463, 6199.380061993765, 1525.062086816622, 1552.9905561384965, 1556.894604830583, 1565.9273397722598, 1568.968620627581, 962.0187408842941, 982.8132654795565, 985.5023213277392, 1001.7095042437758, 1009.9697009089739, 5273.048971880352, 5288.889333239986, 5302.469753024667, 5318.893622127536, 5334.41280978725, 5532.114861622121, 5561.777528898799, 5594.692291923902, 5636.971815140898, 5664.830055098271, 5335.599830012765, 5392.245085688007, 5526.784107496344, 6013.759449622054, 6025.9096113558335, 3377.6622337766516, 3399.7280217582534, 3403.8638454461543, 3425.3491836551475, 3432.1419645088727, 6214.347493513116, 6541.182352205974, 6591.604503729792, 6603.537752357289, 6668.933310666928, 6448.838779030468, 6474.741010359533, 6500.804975850732, 6518.837029074216, 6523.0, 6295.118683384421, 6534.346565343428, 6582.605043697394, 6605.306442823435, 6622.238442579069, 6310.400511951358, 6319.431251187415, 6338.0, 6355.523335749745, 6363.809085727436, 5956.731947062306, 6290.748370065146, 6296.748130074746, 6308.968455157695, 6327.493800495858, 6498.772542960974, 6537.738490460329, 6543.574667646588, 6554.918438457601, 6572.718319927568, 4410.933835992527, 4468.932966005447, 4469.798859051415, 4484.641228701761, 4498.955010449854, 6254.655993920378, 6323.336049714714, 6341.587796793194, 6341.936580634135, 6492.967535162483, 6120.908186377297, 6133.969330153321, 6162.907556386747, 6163.260408750979, 6176.258848938156, 5915.763369465345, 6106.1146133811235, 6110.175126357884, 6151.723172457339, 6191.690415479118, 5990.940090599038, 6010.54920880927, 6049.697515124314, 6055.969720151371, 6057.727402266997, 6151.876962460815, 6188.195534580475, 6226.439620434002, 6234.127222188988, 6240.219972503437, 5834.0, 6011.308699499438, 6056.636601803906, 6073.331933487225, 6122.0], "value": 4637.010684259494, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.7597332813493, 816.0370762500255, 817.9100298967113, 877.9868301975471, 901.6422056322718, 15745.685086298266, 16039.117848518326, 16049.197540123005, 16210.0, 16668.083255420977, 17227.310907563715, 17277.91361043193, 17519.38682146122, 17532.912335438337, 17683.027433491185, 882.9558522073903, 884.9646014159426, 889.5552223888056, 896.5203616065422, 896.9955150224272, 873.1399571422144, 907.2469850024464, 909.1408618855185, 913.4793167894303, 915.601713254733, 941.9058094190594, 948.3124734567452, 948.3503799897093, 949.8290307744603, 950.2920324358363, 931.0642803982023, 934.6074648647584, 936.8688383626297, 939.6899023322321, 947.0624082158682, 687.7695971849437, 694.4895501806168, 695.1484431571336, 695.183159787248, 696.606417374182, 16608.086555239457, 16634.251458684266, 16691.83308166915, 16710.164491775362, 16716.24776885043, 15566.29951652167, 15571.610709732235, 15666.686666266725, 15914.204289785464, 15930.88483806134, 12804.039697022761, 12894.627820731024, 12983.09118361715, 13055.86944130556, 13115.606531804062, 4124.91750164998, 4130.215259100762, 4164.250434921743, 4223.429836972, 4223.493180818322, 77455.0, 78858.0, 80624.59687701642, 81101.0, 82954.58522707348, 12196.39018049094, 12201.084918631139, 12356.62930112098, 12396.81404778929, 12670.49318027287, 23096.538069238857, 23172.18897338585, 23235.535289294457, 23247.651285230735, 23381.0, 9157.725268241964, 9216.493092879957, 9360.765980850398, 9516.619335226653, 9544.61821527145, 5111.463296353903, 5198.194279886624, 5246.973765131226, 5273.077211488051, 5313.123334649817, 3780.2628487444686, 3918.392649139388, 3938.7439816411843, 3945.4279129526058, 3946.1121247719034, 662.4435474201694, 672.9024291477708, 677.6036018928884, 687.8693048320803, 691.4226620771611, 682.2836022176793, 777.6383981448654, 782.0576205672152, 786.3669745854642, 797.8165022044963, 10497.527611257512, 10507.947460262803, 10513.632022879163, 10675.25273230882, 10795.622153224756, 659.409828203755, 768.8270139218743, 804.3444592656966, 816.5998660656236, 826.1490664615455, 4938.555530002317, 4999.0, 5113.642045056885, 5141.408737995103, 5177.508136727005, 107746.0, 117667.41166294114, 119978.4001079989, 122429.0, 123754.0, 41857.74426767202, 64033.679831600544, 68167.0, 95636.52181739047, 104577.47711261395, 87215.0, 88402.11597884068, 88936.555317223, 89489.0, 89760.0, 9619.134277915022, 9679.08048735369, 9703.708888733348, 9776.21790256792, 9895.059969302905, 50290.748546258495, 51257.48742512527, 52104.47895520996, 53237.467625323254, 53783.92432151257, 68836.6558167206, 77044.0, 77273.0, 77471.61264193643, 78226.21773782418, 12397.318147501974, 12410.503579857066, 12459.750804983669, 12579.119461637598, 12943.482260709467, 13279.406471223516, 13574.796378054534, 13657.931710341385, 13760.724785504433, 13766.380512876744, 13162.736745265232, 13446.663833404244, 13622.86377136216, 13890.722185556435, 13899.444022239402, 13274.867251327363, 13399.397027133607, 13599.796003059764, 13607.727845443234, 13875.236861972688, 12861.678458038625, 13046.282454465096, 13485.123466974615, 13534.526291579747, 13847.584572462842, 10607.363558186533, 10700.0, 10930.890691092987, 10982.341059536453, 11162.720931976766, 11017.283876548, 11164.720881978015, 11263.155263355116, 11337.546498139982, 11418.771624567627], "value": 7941.406360356906, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1519.7999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 106.0, 112.0, 110.0, 111.0, 112.0, 111.0, 110.0, 111.0, 112.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 159.0, 176.0, 128.0, 158.0, 165.0, 128.0, 199.0, 131.0], "value": 152.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 163.0, 163.0, 162.0, 161.0, 164.0, 163.0, 164.0, 165.0, 162.0], "value": 163.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 175.0, 76.0, 76.0, 77.0, 75.0, 161.0, 75.0], "value": 94.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 148.0, 84.0, 88.0, 85.0, 139.0, 85.0, 85.0, 144.0], "value": 102.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0, 118.0], "value": 118.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 147.0, 146.0, 148.0, 149.0, 147.0, 148.0, 147.0, 150.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 94.0, 96.0], "value": 95.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 53.0, 53.0, 52.0, 58.0, 54.0, 55.0, 52.0, 53.0], "value": 53.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 59.0, 60.0, 60.0, 60.0, 60.0, 60.0, 61.0, 60.0], "value": 60.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 76.0, 74.0, 78.0, 77.0, 77.0, 80.0, 78.0, 104.0, 76.0], "value": 80.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 121.0, 119.0, 125.0, 120.0, 131.0, 119.0, 125.0, 122.0, 127.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 153.0, 155.0, 152.0, 153.0, 158.0, 167.0, 153.0, 159.0, 158.0], "value": 156.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 65.0, 62.0, 66.0, 61.0, 62.0, 62.0, 61.0, 62.0], "value": 62.8, "unit": "score"}]}]} 02:49:38 INFO - Return code: 0 02:49:38 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:49:38 ERROR - # TBPL SUCCESS # 02:49:38 INFO - Running post-action listener: _resource_record_post_action 02:49:38 INFO - ##### 02:49:38 INFO - ##### Finished run-tests step (success) 02:49:38 INFO - ##### 02:49:38 INFO - Running post-run listener: _resource_record_post_run 02:49:39 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 504365056; Read time: 280; Write time: 546868 02:49:39 INFO - TinderboxPrint: CPU usage
13.4% 02:49:39 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 280 02:49:39 INFO - TinderboxPrint: I/O write bytes / time
504,365,056 / 546,868 02:49:39 INFO - TinderboxPrint: CPU idle
8,215.7 (86.6%) 02:49:39 INFO - TinderboxPrint: CPU user
1,212.5 (12.8%) 02:49:39 INFO - TinderboxPrint: Swap in / out
0 / 0 02:49:39 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 4096; Write bytes: 258912256; Read time: 280; Write time: 333480 02:49:39 INFO - run-tests - Wall time: 1173s; CPU: 13.0%; Read bytes: 0; Write bytes: 244867072; Read time: 0; Write time: 213376 02:49:39 INFO - Running post-run listener: _upload_blobber_files 02:49:39 INFO - Blob upload gear active. 02:49:39 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:49:39 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 02:49:39 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:49:39 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:49:40 INFO - (blobuploader) - INFO - Open directory for files ... 02:49:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 02:49:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 02:49:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:40 INFO - (blobuploader) - INFO - Done attempting. 02:49:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:49:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:44 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:49:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:44 INFO - (blobuploader) - INFO - Done attempting. 02:49:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 02:49:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:49:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:49:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 02:49:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:49:45 INFO - (blobuploader) - INFO - Done attempting. 02:49:45 INFO - (blobuploader) - INFO - Iteration through files over. 02:49:45 INFO - Return code: 0 02:49:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:49:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:49:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2002fb70e7d87803a5c6515ce35fa5622bdd1158565efa049116cc9bee53d1a6b646bcff082f9fd039955acee6b3ca564848f85ca181dd7b0110b54730f5256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27d8c69df8205b9bca3e556cff71c5a1c0ed719f9b4a4c211377046eeedfb0c2a2c1e4d204495c0f122a59026037a0a1244d0c88d27d7af57232604fab0cc17c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7452372142c6e57dc86199ea2f07466193d4a4bdfc86a3b1dba1503a8ba313fc780a56bd504eb8b40780ed87f41a8da1bfdb747740bd5a1d0e9c60c289f6f86e"} 02:49:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:49:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:49:45 INFO - Contents: 02:49:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2002fb70e7d87803a5c6515ce35fa5622bdd1158565efa049116cc9bee53d1a6b646bcff082f9fd039955acee6b3ca564848f85ca181dd7b0110b54730f5256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27d8c69df8205b9bca3e556cff71c5a1c0ed719f9b4a4c211377046eeedfb0c2a2c1e4d204495c0f122a59026037a0a1244d0c88d27d7af57232604fab0cc17c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7452372142c6e57dc86199ea2f07466193d4a4bdfc86a3b1dba1503a8ba313fc780a56bd504eb8b40780ed87f41a8da1bfdb747740bd5a1d0e9c60c289f6f86e"} 02:49:45 INFO - Running post-run listener: copy_logs_to_upload_dir 02:49:45 INFO - Copying logs to upload dir... 02:49:45 INFO - mkdir: /builds/slave/test/build/upload/logs 02:49:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.925281 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-06-07 02:49:44.825993) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:44.829186) ========= 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=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2002fb70e7d87803a5c6515ce35fa5622bdd1158565efa049116cc9bee53d1a6b646bcff082f9fd039955acee6b3ca564848f85ca181dd7b0110b54730f5256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27d8c69df8205b9bca3e556cff71c5a1c0ed719f9b4a4c211377046eeedfb0c2a2c1e4d204495c0f122a59026037a0a1244d0c88d27d7af57232604fab0cc17c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7452372142c6e57dc86199ea2f07466193d4a4bdfc86a3b1dba1503a8ba313fc780a56bd504eb8b40780ed87f41a8da1bfdb747740bd5a1d0e9c60c289f6f86e"} build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011428 build_url: 'https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b2002fb70e7d87803a5c6515ce35fa5622bdd1158565efa049116cc9bee53d1a6b646bcff082f9fd039955acee6b3ca564848f85ca181dd7b0110b54730f5256", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/27d8c69df8205b9bca3e556cff71c5a1c0ed719f9b4a4c211377046eeedfb0c2a2c1e4d204495c0f122a59026037a0a1244d0c88d27d7af57232604fab0cc17c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/7452372142c6e57dc86199ea2f07466193d4a4bdfc86a3b1dba1503a8ba313fc780a56bd504eb8b40780ed87f41a8da1bfdb747740bd5a1d0e9c60c289f6f86e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:44.854927) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:44.855241) ========= 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=836cfdc75598d54cb747368e000001a9-1465291753.104124-1984657000 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004514 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:49:44.939915) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:49:44.940303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:49:44.940638) ========= ========= Total master_lag: 0.17 =========