builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1465291598.56 results: success (0) buildid: 20160606202128 builduid: 7ec3cba5ae654a229f94a8ace0e91e74 revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.555431) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.555979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.556313) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.571895) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.572241) ========= 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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-07 02:26:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 224M=0s 2016-06-07 02:26:38 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116598 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.703594) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.704002) ========= 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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023061 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:38.754067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:26:38.754487) ========= 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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-07 02:26:39,084 truncating revision to first 12 chars 2016-06-07 02:26:39,084 Setting DEBUG logging. 2016-06-07 02:26:39,084 attempt 1/10 2016-06-07 02:26:39,084 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:26:39,840 unpacking tar archive at: mozilla-aurora-e70892847544/testing/mozharness/ program finished with exit code 0 elapsedTime=1.119271 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 02:26:39.887973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:39.888368) ========= script_repo_revision: e70892847544db94d801f80543fe8a7f6d836f90 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:39.888835) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:39.889145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 02:26:39.900172) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-07 02:26:39.900620) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:26:40 INFO - MultiFileLogger online at 20160607 02:26:40 in /builds/slave/test 02:26:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:26:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:26:40 INFO - {'append_to_log': False, 02:26:40 INFO - 'base_work_dir': '/builds/slave/test', 02:26:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 02:26:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:26:40 INFO - 'branch': 'Mozilla-Aurora', 02:26:40 INFO - 'buildbot_json_path': 'buildprops.json', 02:26:40 INFO - 'config_files': ('talos/linux_config.py',), 02:26:40 INFO - 'default_actions': ('clobber', 02:26:40 INFO - 'read-buildbot-config', 02:26:40 INFO - 'download-and-extract', 02:26:40 INFO - 'populate-webroot', 02:26:40 INFO - 'create-virtualenv', 02:26:40 INFO - 'install', 02:26:40 INFO - 'run-tests'), 02:26:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:26:40 INFO - 'download_minidump_stackwalk': True, 02:26:40 INFO - 'download_symbols': 'ondemand', 02:26:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:26:40 INFO - 'tooltool.py': '/tools/tooltool.py', 02:26:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:26:40 INFO - '/tools/misc-python/virtualenv.py')}, 02:26:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:26:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:26:40 INFO - 'installer_path': 'installer.exe', 02:26:40 INFO - 'log_level': 'info', 02:26:40 INFO - 'log_name': 'talos', 02:26:40 INFO - 'log_to_console': True, 02:26:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:26:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:26:40 INFO - 'opt_config_files': (), 02:26:40 INFO - 'pip_index': False, 02:26:40 INFO - 'sps_profile': False, 02:26:40 INFO - 'sps_profile_interval': 0, 02:26:40 INFO - 'suite': 'dromaeojs', 02:26:40 INFO - 'system_bits': '32', 02:26:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:26:40 INFO - 'title': 'talos-linux64-ix-016', 02:26:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:26:40 INFO - 'use_talos_json': True, 02:26:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:26:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:26:40 INFO - 'work_dir': 'build'} 02:26:40 INFO - ##### 02:26:40 INFO - ##### Running clobber step. 02:26:40 INFO - ##### 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: clobber 02:26:40 INFO - rmtree: /builds/slave/test/build 02:26:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:26:40 INFO - Running post-action listener: _resource_record_post_action 02:26:40 INFO - ##### 02:26:40 INFO - ##### Finished clobber step (success) 02:26:40 INFO - ##### 02:26:40 INFO - ##### 02:26:40 INFO - ##### Running read-buildbot-config step. 02:26:40 INFO - ##### 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: read_buildbot_config 02:26:40 INFO - Using buildbot properties: 02:26:40 INFO - { 02:26:40 INFO - "project": "", 02:26:40 INFO - "product": "firefox", 02:26:40 INFO - "script_repo_revision": "production", 02:26:40 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 02:26:40 INFO - "repository": "", 02:26:40 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 02:26:40 INFO - "buildid": "20160606202128", 02:26:40 INFO - "pgo_build": "True", 02:26:40 INFO - "basedir": "/builds/slave/test", 02:26:40 INFO - "buildnumber": 371, 02:26:40 INFO - "slavename": "talos-linux64-ix-016", 02:26:40 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 02:26:40 INFO - "platform": "ubuntu64_hw", 02:26:40 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 02:26:40 INFO - "branch": "mozilla-aurora", 02:26:40 INFO - "repo_path": "releases/mozilla-aurora", 02:26:40 INFO - "revision": "e70892847544db94d801f80543fe8a7f6d836f90", 02:26:40 INFO - "stage_platform": "linux64-pgo", 02:26:40 INFO - "builduid": "7ec3cba5ae654a229f94a8ace0e91e74", 02:26:40 INFO - "slavebuilddir": "test" 02:26:40 INFO - } 02:26:40 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:26:40 INFO - Running post-action listener: _resource_record_post_action 02:26:40 INFO - ##### 02:26:40 INFO - ##### Finished read-buildbot-config step (success) 02:26:40 INFO - ##### 02:26:40 INFO - ##### 02:26:40 INFO - ##### Running download-and-extract step. 02:26:40 INFO - ##### 02:26:40 INFO - Running pre-action listener: _resource_record_pre_action 02:26:40 INFO - Running main action method: download_and_extract 02:26:40 INFO - mkdir: /builds/slave/test/build/tests 02:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:40 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:26:40 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:26:40 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:26:40 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:26:40 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:26:41 INFO - Downloaded 1361 bytes. 02:26:42 INFO - Reading from file /builds/slave/test/build/firefox-49.0a2.en-US.linux-x86_64.test_packages.json 02:26:42 INFO - Using the following test package requirements: 02:26:42 INFO - {u'common': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:42 INFO - u'cppunittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 02:26:42 INFO - u'gtest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.gtest.tests.zip'], 02:26:42 INFO - u'jittest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'jsshell-linux-x86_64.zip'], 02:26:42 INFO - u'mochitest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 02:26:42 INFO - u'mozbase': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'], 02:26:42 INFO - u'reftest': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.reftest.tests.zip'], 02:26:42 INFO - u'talos': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.talos.tests.zip'], 02:26:42 INFO - u'web-platform': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 02:26:42 INFO - u'xpcshell': [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip', 02:26:42 INFO - u'firefox-49.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 02:26:42 INFO - Downloading packages: [u'firefox-49.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 02:26:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:42 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:26:42 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:26:42 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:26:42 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:26:42 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:26:46 INFO - Downloaded 24473779 bytes. 02:26:46 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:26:46 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:26:47 INFO - Return code: 0 02:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:47 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:26:49 INFO - Downloaded 24473779 bytes. 02:26:49 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:26:49 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:26:50 INFO - Return code: 0 02:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:50 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:26:50 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:26:50 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:26:50 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:26:50 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:26:51 INFO - Downloaded 10833369 bytes. 02:26:51 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:26:51 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:26:51 INFO - Return code: 0 02:26:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:51 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:26:51 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:26:51 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:26:51 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:26:51 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:26:52 INFO - Downloaded 63553597 bytes. 02:26:52 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:26:52 INFO - mkdir: /builds/slave/test/properties 02:26:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:26:52 INFO - Writing to file /builds/slave/test/properties/build_url 02:26:52 INFO - Contents: 02:26:52 INFO - build_url:https://queue.taskcluster.net/v1/task/Q4TsFUxRQcOCi0AHQQ1VQg/artifacts/public/build/firefox-49.0a2.en-US.linux-x86_64.tar.bz2 02:26:53 INFO - Running post-action listener: _resource_record_post_action 02:26:53 INFO - Running post-action listener: set_extra_try_arguments 02:26:53 INFO - ##### 02:26:53 INFO - ##### Finished download-and-extract step (success) 02:26:53 INFO - ##### 02:26:53 INFO - ##### 02:26:53 INFO - ##### Running populate-webroot step. 02:26:53 INFO - ##### 02:26:53 INFO - Running pre-action listener: _resource_record_pre_action 02:26:53 INFO - Running main action method: populate_webroot 02:26:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:26:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:26:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:26:53 INFO - '--tppagecycles', 02:26:53 INFO - '7'], 02:26:53 INFO - 'tests': ['tsvgm']}}, 02:26:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:26:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:26:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:26:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:26:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:26:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['damp', 'tps']}, 02:26:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['damp', 'tps']}, 02:26:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['dromaeo_dom']}, 02:26:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:26:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['a11yr', 02:26:53 INFO - 'ts_paint', 02:26:53 INFO - 'tpaint', 02:26:53 INFO - 'sessionrestore', 02:26:53 INFO - 'sessionrestore_no_auto_restore', 02:26:53 INFO - 'tabpaint']}, 02:26:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tsvgx', 02:26:53 INFO - 'tsvgr_opacity', 02:26:53 INFO - 'tart', 02:26:53 INFO - 'tscrollx', 02:26:53 INFO - 'cart']}, 02:26:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:26:53 INFO - 'tsvgr_opacity', 02:26:53 INFO - 'tart', 02:26:53 INFO - 'tscrollx', 02:26:53 INFO - 'cart']}, 02:26:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s'], 02:26:53 INFO - 'tests': ['tp5o']}, 02:26:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'tests': ['tp5o']}, 02:26:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--disable-e10s', 02:26:53 INFO - '--xperf_path', 02:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:53 INFO - 'tests': ['tp5n']}, 02:26:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:26:53 INFO - 'talos_options': ['--xperf_path', 02:26:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:26:53 INFO - 'tests': ['tp5n']}}, 02:26:53 INFO - 'talos.zip': {'path': '', 02:26:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:26:53 INFO - Running post-action listener: _resource_record_post_action 02:26:53 INFO - ##### 02:26:53 INFO - ##### Finished populate-webroot step (success) 02:26:53 INFO - ##### 02:26:53 INFO - ##### 02:26:53 INFO - ##### Running create-virtualenv step. 02:26:53 INFO - ##### 02:26:53 INFO - Running pre-action listener: _resource_record_pre_action 02:26:53 INFO - Running main action method: create_virtualenv 02:26:53 INFO - Creating virtualenv /builds/slave/test/build/venv 02:26:53 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:26:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:26:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:26:53 INFO - Using real prefix '/usr' 02:26:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:26:54 INFO - Installing distribute.............................................................................................................................................................................................done. 02:26:56 INFO - Installing pip.................done. 02:26:56 INFO - Return code: 0 02:26:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 02:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 02:26:56 INFO - Using env: {'DISPLAY': ':0', 02:26:56 INFO - 'HOME': '/home/cltbld', 02:26:56 INFO - 'LANG': 'en_US.UTF-8', 02:26:56 INFO - 'LANGUAGE': 'en_US:en', 02:26:56 INFO - 'LOGNAME': 'cltbld', 02:26:56 INFO - 'MAIL': '/var/mail/cltbld', 02:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:56 INFO - 'MOZ_NO_REMOTE': '1', 02:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:56 INFO - 'NO_EM_RESTART': '1', 02:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:56 INFO - 'PWD': '/builds/slave/test', 02:26:56 INFO - 'SHELL': '/bin/bash', 02:26:56 INFO - 'SHLVL': '1', 02:26:56 INFO - 'TERM': 'linux', 02:26:56 INFO - 'TMOUT': '86400', 02:26:56 INFO - 'USER': 'cltbld', 02:26:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:56 INFO - '_': '/tools/buildbot/bin/python'} 02:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:56 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:26:56 INFO - Cleaning up... 02:26:56 INFO - Return code: 0 02:26:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 02:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:26:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 02:26:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 02:26:56 INFO - Using env: {'DISPLAY': ':0', 02:26:56 INFO - 'HOME': '/home/cltbld', 02:26:56 INFO - 'LANG': 'en_US.UTF-8', 02:26:56 INFO - 'LANGUAGE': 'en_US:en', 02:26:56 INFO - 'LOGNAME': 'cltbld', 02:26:56 INFO - 'MAIL': '/var/mail/cltbld', 02:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:56 INFO - 'MOZ_NO_REMOTE': '1', 02:26:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:56 INFO - 'NO_EM_RESTART': '1', 02:26:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:56 INFO - 'PWD': '/builds/slave/test', 02:26:56 INFO - 'SHELL': '/bin/bash', 02:26:56 INFO - 'SHLVL': '1', 02:26:56 INFO - 'TERM': 'linux', 02:26:56 INFO - 'TMOUT': '86400', 02:26:56 INFO - 'USER': 'cltbld', 02:26:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:56 INFO - '_': '/tools/buildbot/bin/python'} 02:26:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:56 INFO - Downloading/unpacking psutil>=3.1.1 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:26:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:58 INFO - Installing collected packages: psutil 02:26:58 INFO - Running setup.py install for psutil 02:26:58 INFO - building 'psutil._psutil_linux' extension 02:26:58 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:26:58 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:26:58 INFO - building 'psutil._psutil_posix' extension 02:26:58 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:26:59 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:26:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:26:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:26:59 INFO - Successfully installed psutil 02:26:59 INFO - Cleaning up... 02:26:59 INFO - Return code: 0 02:26:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 02:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:26:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:26:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:26:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:26:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 02:26:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 02:26:59 INFO - Using env: {'DISPLAY': ':0', 02:26:59 INFO - 'HOME': '/home/cltbld', 02:26:59 INFO - 'LANG': 'en_US.UTF-8', 02:26:59 INFO - 'LANGUAGE': 'en_US:en', 02:26:59 INFO - 'LOGNAME': 'cltbld', 02:26:59 INFO - 'MAIL': '/var/mail/cltbld', 02:26:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:26:59 INFO - 'MOZ_NO_REMOTE': '1', 02:26:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:26:59 INFO - 'NO_EM_RESTART': '1', 02:26:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:26:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:26:59 INFO - 'PWD': '/builds/slave/test', 02:26:59 INFO - 'SHELL': '/bin/bash', 02:26:59 INFO - 'SHLVL': '1', 02:26:59 INFO - 'TERM': 'linux', 02:26:59 INFO - 'TMOUT': '86400', 02:26:59 INFO - 'USER': 'cltbld', 02:26:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:26:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:26:59 INFO - '_': '/tools/buildbot/bin/python'} 02:26:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:26:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:26:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:26:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 02:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:27:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 02:27:01 INFO - Installing collected packages: mozsystemmonitor 02:27:01 INFO - Running setup.py install for mozsystemmonitor 02:27:01 INFO - Successfully installed mozsystemmonitor 02:27:01 INFO - Cleaning up... 02:27:01 INFO - Return code: 0 02:27:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 02:27:01 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:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:01 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:27:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:01 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:01 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:27:01 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:27:01 INFO - Using env: {'DISPLAY': ':0', 02:27:01 INFO - 'HOME': '/home/cltbld', 02:27:01 INFO - 'LANG': 'en_US.UTF-8', 02:27:01 INFO - 'LANGUAGE': 'en_US:en', 02:27:01 INFO - 'LOGNAME': 'cltbld', 02:27:01 INFO - 'MAIL': '/var/mail/cltbld', 02:27:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:01 INFO - 'MOZ_NO_REMOTE': '1', 02:27:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:01 INFO - 'NO_EM_RESTART': '1', 02:27:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:01 INFO - 'PWD': '/builds/slave/test', 02:27:01 INFO - 'SHELL': '/bin/bash', 02:27:01 INFO - 'SHLVL': '1', 02:27:01 INFO - 'TERM': 'linux', 02:27:01 INFO - 'TMOUT': '86400', 02:27:01 INFO - 'USER': 'cltbld', 02:27:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:01 INFO - '_': '/tools/buildbot/bin/python'} 02:27:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:01 INFO - Downloading/unpacking jsonschema==2.5.1 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:27:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:03 INFO - Downloading functools32-3.2.3-2.tar.gz 02:27:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:27:03 INFO - warning: no files found matching '*.txt' 02:27:03 INFO - no previously-included directories found matching 'build' 02:27:03 INFO - no previously-included directories found matching 'dist' 02:27:03 INFO - no previously-included directories found matching '.git*' 02:27:03 INFO - Installing collected packages: jsonschema, functools32 02:27:04 INFO - Running setup.py install for functools32 02:27:04 INFO - warning: no files found matching '*.txt' 02:27:04 INFO - no previously-included directories found matching 'build' 02:27:04 INFO - no previously-included directories found matching 'dist' 02:27:04 INFO - no previously-included directories found matching '.git*' 02:27:04 INFO - Successfully installed jsonschema functools32 02:27:04 INFO - Cleaning up... 02:27:04 INFO - Return code: 0 02:27:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:27:04 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:27:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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:27:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:04 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:04 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:27:04 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:27:04 INFO - Using env: {'DISPLAY': ':0', 02:27:04 INFO - 'HOME': '/home/cltbld', 02:27:04 INFO - 'LANG': 'en_US.UTF-8', 02:27:04 INFO - 'LANGUAGE': 'en_US:en', 02:27:04 INFO - 'LOGNAME': 'cltbld', 02:27:04 INFO - 'MAIL': '/var/mail/cltbld', 02:27:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:04 INFO - 'MOZ_NO_REMOTE': '1', 02:27:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:04 INFO - 'NO_EM_RESTART': '1', 02:27:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:04 INFO - 'PWD': '/builds/slave/test', 02:27:04 INFO - 'SHELL': '/bin/bash', 02:27:04 INFO - 'SHLVL': '1', 02:27:04 INFO - 'TERM': 'linux', 02:27:04 INFO - 'TMOUT': '86400', 02:27:04 INFO - 'USER': 'cltbld', 02:27:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:04 INFO - '_': '/tools/buildbot/bin/python'} 02:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:04 INFO - Downloading/unpacking blobuploader==1.2.4 02:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:04 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:27:06 INFO - Downloading blobuploader-1.2.4.tar.gz 02:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:27:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:27:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:07 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:27:07 INFO - Downloading docopt-0.6.1.tar.gz 02:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:27:07 INFO - Installing collected packages: blobuploader, requests, docopt 02:27:07 INFO - Running setup.py install for blobuploader 02:27:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:27:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:27:07 INFO - Running setup.py install for requests 02:27:07 INFO - Running setup.py install for docopt 02:27:07 INFO - Successfully installed blobuploader requests docopt 02:27:07 INFO - Cleaning up... 02:27:07 INFO - Return code: 0 02:27:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:07 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:07 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:27:07 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:27:07 INFO - Using env: {'DISPLAY': ':0', 02:27:07 INFO - 'HOME': '/home/cltbld', 02:27:07 INFO - 'LANG': 'en_US.UTF-8', 02:27:07 INFO - 'LANGUAGE': 'en_US:en', 02:27:07 INFO - 'LOGNAME': 'cltbld', 02:27:07 INFO - 'MAIL': '/var/mail/cltbld', 02:27:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:07 INFO - 'MOZ_NO_REMOTE': '1', 02:27:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:07 INFO - 'NO_EM_RESTART': '1', 02:27:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:07 INFO - 'PWD': '/builds/slave/test', 02:27:07 INFO - 'SHELL': '/bin/bash', 02:27:07 INFO - 'SHLVL': '1', 02:27:07 INFO - 'TERM': 'linux', 02:27:07 INFO - 'TMOUT': '86400', 02:27:07 INFO - 'USER': 'cltbld', 02:27:07 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:07 INFO - '_': '/tools/buildbot/bin/python'} 02:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:08 INFO - Running setup.py (path:/tmp/pip-EpYPHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:08 INFO - Running setup.py (path:/tmp/pip-xwExH7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:08 INFO - Running setup.py (path:/tmp/pip-dvHwD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:08 INFO - Running setup.py (path:/tmp/pip-YOwaAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:08 INFO - Running setup.py (path:/tmp/pip-yCgVgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:08 INFO - Running setup.py (path:/tmp/pip-x21h1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:08 INFO - Running setup.py (path:/tmp/pip-6O6pgq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:08 INFO - Running setup.py (path:/tmp/pip-pVKA9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:08 INFO - Running setup.py (path:/tmp/pip-UZo2Uv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:08 INFO - Running setup.py (path:/tmp/pip-WRkj0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:08 INFO - Running setup.py (path:/tmp/pip-tynfyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:08 INFO - Running setup.py (path:/tmp/pip-L8cBfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:09 INFO - Running setup.py (path:/tmp/pip-iO4j9a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:09 INFO - Running setup.py (path:/tmp/pip-9vYY4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:09 INFO - Running setup.py (path:/tmp/pip-L5qFoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:09 INFO - Running setup.py (path:/tmp/pip-ias4gq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:09 INFO - Running setup.py (path:/tmp/pip-iADzL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:27:09 INFO - Running setup.py install for manifestparser 02:27:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:27:09 INFO - Running setup.py install for mozcrash 02:27:09 INFO - Running setup.py install for mozdebug 02:27:09 INFO - Running setup.py install for mozdevice 02:27:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:27:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:27:09 INFO - Running setup.py install for mozfile 02:27:09 INFO - Running setup.py install for mozhttpd 02:27:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:27:09 INFO - Running setup.py install for mozinfo 02:27:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for mozInstall 02:27:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for mozleak 02:27:10 INFO - Running setup.py install for mozlog 02:27:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for moznetwork 02:27:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for mozprocess 02:27:10 INFO - Running setup.py install for mozprofile 02:27:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for mozrunner 02:27:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:27:10 INFO - Running setup.py install for mozscreenshot 02:27:10 INFO - Running setup.py install for moztest 02:27:11 INFO - Running setup.py install for mozversion 02:27:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:27:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:27:11 INFO - Cleaning up... 02:27:11 INFO - Return code: 0 02:27:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:11 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:11 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:27:11 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:27:11 INFO - Using env: {'DISPLAY': ':0', 02:27:11 INFO - 'HOME': '/home/cltbld', 02:27:11 INFO - 'LANG': 'en_US.UTF-8', 02:27:11 INFO - 'LANGUAGE': 'en_US:en', 02:27:11 INFO - 'LOGNAME': 'cltbld', 02:27:11 INFO - 'MAIL': '/var/mail/cltbld', 02:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:11 INFO - 'MOZ_NO_REMOTE': '1', 02:27:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:11 INFO - 'NO_EM_RESTART': '1', 02:27:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:11 INFO - 'PWD': '/builds/slave/test', 02:27:11 INFO - 'SHELL': '/bin/bash', 02:27:11 INFO - 'SHLVL': '1', 02:27:11 INFO - 'TERM': 'linux', 02:27:11 INFO - 'TMOUT': '86400', 02:27:11 INFO - 'USER': 'cltbld', 02:27:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:11 INFO - '_': '/tools/buildbot/bin/python'} 02:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:27:11 INFO - Running setup.py (path:/tmp/pip-dJDYVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:27:11 INFO - Running setup.py (path:/tmp/pip-58Awoe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:27:11 INFO - Running setup.py (path:/tmp/pip-S9gDZu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:27:11 INFO - Running setup.py (path:/tmp/pip-PSlNA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:27:11 INFO - Running setup.py (path:/tmp/pip-y0YaOQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:27:11 INFO - Running setup.py (path:/tmp/pip-1q6BxP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:27:11 INFO - Running setup.py (path:/tmp/pip-jA016x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:27:11 INFO - Running setup.py (path:/tmp/pip-oeFVS7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:27:11 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:27:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:27:11 INFO - Running setup.py (path:/tmp/pip-qpcId2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:27:12 INFO - Running setup.py (path:/tmp/pip-FcjOkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:27:12 INFO - Running setup.py (path:/tmp/pip-TXbIVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:27:12 INFO - Running setup.py (path:/tmp/pip-45ZmUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:27:12 INFO - Running setup.py (path:/tmp/pip-hNttZs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:27:12 INFO - Running setup.py (path:/tmp/pip-Ux9klN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:12 INFO - Running setup.py (path:/tmp/pip-NwZyNd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:27:12 INFO - Running setup.py (path:/tmp/pip-6GZHmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:27:12 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:27:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:27:12 INFO - Running setup.py (path:/tmp/pip-KlgfFr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 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:27:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:27:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:27:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:27:14 INFO - Downloading blessings-1.6.tar.gz 02:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:27:14 INFO - Installing collected packages: blessings 02:27:14 INFO - Running setup.py install for blessings 02:27:14 INFO - Successfully installed blessings 02:27:14 INFO - Cleaning up... 02:27:14 INFO - Return code: 0 02:27:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:27:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:14 INFO - Reading from file tmpfile_stdout 02:27:14 INFO - Current package versions: 02:27:14 INFO - argparse == 1.2.1 02:27:14 INFO - blessings == 1.6 02:27:14 INFO - blobuploader == 1.2.4 02:27:14 INFO - docopt == 0.6.1 02:27:14 INFO - functools32 == 3.2.3-2 02:27:14 INFO - jsonschema == 2.5.1 02:27:14 INFO - manifestparser == 1.1 02:27:14 INFO - mozInstall == 1.12 02:27:14 INFO - mozcrash == 0.17 02:27:14 INFO - mozdebug == 0.1 02:27:14 INFO - mozdevice == 0.48 02:27:14 INFO - mozfile == 1.2 02:27:14 INFO - mozhttpd == 0.7 02:27:14 INFO - mozinfo == 0.9 02:27:14 INFO - mozleak == 0.1 02:27:14 INFO - mozlog == 3.2 02:27:14 INFO - moznetwork == 0.27 02:27:14 INFO - mozprocess == 0.22 02:27:14 INFO - mozprofile == 0.28 02:27:14 INFO - mozrunner == 6.11 02:27:14 INFO - mozscreenshot == 0.1 02:27:14 INFO - mozsystemmonitor == 0.3 02:27:14 INFO - moztest == 0.7 02:27:14 INFO - mozversion == 1.4 02:27:14 INFO - psutil == 3.1.1 02:27:14 INFO - requests == 1.2.3 02:27:14 INFO - wsgiref == 0.1.2 02:27:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:14 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:14 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:27:14 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:27:14 INFO - Using env: {'DISPLAY': ':0', 02:27:14 INFO - 'HOME': '/home/cltbld', 02:27:14 INFO - 'LANG': 'en_US.UTF-8', 02:27:14 INFO - 'LANGUAGE': 'en_US:en', 02:27:14 INFO - 'LOGNAME': 'cltbld', 02:27:14 INFO - 'MAIL': '/var/mail/cltbld', 02:27:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:14 INFO - 'MOZ_NO_REMOTE': '1', 02:27:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:14 INFO - 'NO_EM_RESTART': '1', 02:27:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:14 INFO - 'PWD': '/builds/slave/test', 02:27:14 INFO - 'SHELL': '/bin/bash', 02:27:14 INFO - 'SHLVL': '1', 02:27:14 INFO - 'TERM': 'linux', 02:27:14 INFO - 'TMOUT': '86400', 02:27:14 INFO - 'USER': 'cltbld', 02:27:14 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:14 INFO - '_': '/tools/buildbot/bin/python'} 02:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 INFO - Cleaning up... 02:27:15 INFO - Return code: 0 02:27:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:27: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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:15 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 02:27:15 INFO - 'HOME': '/home/cltbld', 02:27:15 INFO - 'LANG': 'en_US.UTF-8', 02:27:15 INFO - 'LANGUAGE': 'en_US:en', 02:27:15 INFO - 'LOGNAME': 'cltbld', 02:27:15 INFO - 'MAIL': '/var/mail/cltbld', 02:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:15 INFO - 'MOZ_NO_REMOTE': '1', 02:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:15 INFO - 'NO_EM_RESTART': '1', 02:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:15 INFO - 'PWD': '/builds/slave/test', 02:27:15 INFO - 'SHELL': '/bin/bash', 02:27:15 INFO - 'SHLVL': '1', 02:27:15 INFO - 'TERM': 'linux', 02:27:15 INFO - 'TMOUT': '86400', 02:27:15 INFO - 'USER': 'cltbld', 02:27:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:15 INFO - '_': '/tools/buildbot/bin/python'} 02:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 02:27:15 INFO - Cleaning up... 02:27:15 INFO - Return code: 0 02:27:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:27: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:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27: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:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:27:15 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 0x7f47dbd6bf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fa08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x206e2e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, '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': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', '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:27:15 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:27:15 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:27:15 INFO - Using env: {'DISPLAY': ':0', 02:27:15 INFO - 'HOME': '/home/cltbld', 02:27:15 INFO - 'LANG': 'en_US.UTF-8', 02:27:15 INFO - 'LANGUAGE': 'en_US:en', 02:27:15 INFO - 'LOGNAME': 'cltbld', 02:27:15 INFO - 'MAIL': '/var/mail/cltbld', 02:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:15 INFO - 'MOZ_NO_REMOTE': '1', 02:27:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:15 INFO - 'NO_EM_RESTART': '1', 02:27:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:15 INFO - 'PWD': '/builds/slave/test', 02:27:15 INFO - 'SHELL': '/bin/bash', 02:27:15 INFO - 'SHLVL': '1', 02:27:15 INFO - 'TERM': 'linux', 02:27:15 INFO - 'TMOUT': '86400', 02:27:15 INFO - 'USER': 'cltbld', 02:27:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:15 INFO - '_': '/tools/buildbot/bin/python'} 02:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:27:15 INFO - Downloading/unpacking flake8 02:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:15 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:27:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:27:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:27:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:17 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:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:18 INFO - no previously-included directories found matching 'docs/_build' 02:27:18 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:27:18 INFO - Running setup.py install for pep8 02:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:27:18 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:27:18 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:27:18 INFO - no previously-included directories found matching 'docs/_build' 02:27:18 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:27:18 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:27:18 INFO - Cleaning up... 02:27:18 INFO - Return code: 0 02:27:18 INFO - Running post-action listener: _resource_record_post_action 02:27:18 INFO - Running post-action listener: _start_resource_monitoring 02:27:18 INFO - Starting resource monitoring. 02:27:18 INFO - ##### 02:27:18 INFO - ##### Finished create-virtualenv step (success) 02:27:18 INFO - ##### 02:27:18 INFO - ##### 02:27:18 INFO - ##### Running install step. 02:27:18 INFO - ##### 02:27:18 INFO - Running pre-action listener: _resource_record_pre_action 02:27:18 INFO - Running main action method: install 02:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:27:18 INFO - Reading from file tmpfile_stdout 02:27:18 INFO - Detecting whether we're running mozinstall >=1.0... 02:27:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:27:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:27:18 INFO - Reading from file tmpfile_stdout 02:27:18 INFO - Output received: 02:27:18 INFO - Usage: mozinstall [options] installer 02:27:18 INFO - Options: 02:27:18 INFO - -h, --help show this help message and exit 02:27:18 INFO - -d DEST, --destination=DEST 02:27:18 INFO - Directory to install application into. [default: 02:27:18 INFO - "/builds/slave/test"] 02:27:18 INFO - --app=APP Application being installed. [default: firefox] 02:27:18 INFO - mkdir: /builds/slave/test/build/application 02:27:18 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:27:18 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:27:34 INFO - Reading from file tmpfile_stdout 02:27:34 INFO - Output received: 02:27:34 INFO - /builds/slave/test/build/application/firefox/firefox 02:27:34 INFO - Running post-action listener: _resource_record_post_action 02:27:34 INFO - ##### 02:27:34 INFO - ##### Finished install step (success) 02:27:34 INFO - ##### 02:27:34 INFO - ##### 02:27:34 INFO - ##### Running run-tests step. 02:27:34 INFO - ##### 02:27:34 INFO - Running pre-action listener: _resource_record_pre_action 02:27:34 INFO - Running main action method: run_tests 02:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:27:34 INFO - Python 2.7.3 02:27:34 INFO - Return code: 0 02:27:34 INFO - grabbing minidump binary from tooltool 02:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:27:34 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 0x2068e20>, '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 0x206c3a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x206c830>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:27:34 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:27:34 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:27:34 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:27:34 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:27:34 INFO - Return code: 0 02:27:34 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 02:27:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:27:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:27:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 02:27:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:27:35 INFO - Return code: 0 02:27:35 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', '--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-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 02:27:35 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 --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-016 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 02:27:35 INFO - Using env: {'DISPLAY': ':0', 02:27:35 INFO - 'HOME': '/home/cltbld', 02:27:35 INFO - 'LANG': 'en_US.UTF-8', 02:27:35 INFO - 'LANGUAGE': 'en_US:en', 02:27:35 INFO - 'LOGNAME': 'cltbld', 02:27:35 INFO - 'MAIL': '/var/mail/cltbld', 02:27:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:27:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 02:27:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:27:35 INFO - 'MOZ_NO_REMOTE': '1', 02:27:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:27:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 02:27:35 INFO - 'NO_EM_RESTART': '1', 02:27:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 02:27:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:27:35 INFO - 'PWD': '/builds/slave/test', 02:27:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:27:35 INFO - 'SHELL': '/bin/bash', 02:27:35 INFO - 'SHLVL': '1', 02:27:35 INFO - 'TERM': 'linux', 02:27:35 INFO - 'TMOUT': '86400', 02:27:35 INFO - 'USER': 'cltbld', 02:27:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1465291598.135313-65303513', 02:27:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:27:35 INFO - '_': '/tools/buildbot/bin/python'} 02:27:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--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-016', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 02:27:35 INFO - mozversion application_buildid: 20160606202128 02:27:35 INFO - mozversion application_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:27:35 INFO - mozversion application_display_name: FirefoxDeveloperEdition 02:27:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:27:35 INFO - mozversion application_name: Firefox 02:27:35 INFO - mozversion application_remotingname: firefox-dev 02:27:35 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:35 INFO - mozversion application_vendor: Mozilla 02:27:35 INFO - mozversion application_version: 49.0a2 02:27:35 INFO - mozversion platform_buildid: 20160606202128 02:27:35 INFO - mozversion platform_changeset: e70892847544db94d801f80543fe8a7f6d836f90 02:27:35 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 02:27:35 INFO - mozversion platform_version: 49.0a2 02:27:35 INFO - using testdate: 1465291655 02:27:35 INFO - actual date: 1465291655 02:27:35 INFO - starting webserver on 'localhost:45065' 02:27:35 INFO - SUITE-START | Running 2 tests 02:27:35 INFO - TEST-START | dromaeo_css 02:27:35 INFO - operating with platform_type : linux_ 02:27:35 INFO - Initialising browser for dromaeo_css test... 02:27:35 INFO - TEST-INFO | started process 23351 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNuTd3y/profile http://localhost:45065/getInfo.html) 02:27:40 INFO - PROCESS | 23351 | __metrics Screen width/height:1600/1200 02:27:40 INFO - PROCESS | 23351 | colorDepth:24 02:27:40 INFO - PROCESS | 23351 | Browser inner width/height: 1024/697 02:27:40 INFO - PROCESS | 23351 | __metrics 02:27:40 ERROR - PROCESS | 23351 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:27:41 INFO - PROCESS | 23351 | console.error: PushService: 02:27:41 INFO - PROCESS | 23351 | stateChangeProcessEnqueue: Error transitioning state 02:27:41 INFO - PROCESS | 23351 | UnknownError 02:27:41 INFO - TEST-INFO | 23351: exit 0 02:27:41 INFO - Browser initialized. 02:27:41 INFO - Running cycle 1/1 for dromaeo_css test... 02:27:41 INFO - TEST-INFO | started process 23443 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNuTd3y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:27:53 INFO - PROCESS | 23443 | RSS: Main: 145780736 02:27:53 INFO - PROCESS | 23443 | 02:28:44 INFO - PROCESS | 23443 | 1465291724926 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:30:52 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45065/tests/dromaeo/cssquery-ext.html) 02:30:54 INFO - PROCESS | 23443 | RSS: Main: 257126400 02:30:54 INFO - PROCESS | 23443 | 02:33:56 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-ext.html (next: http://localhost:45065/tests/dromaeo/cssquery-jquery.html) 02:33:57 INFO - PROCESS | 23443 | RSS: Main: 225738752 02:33:57 INFO - PROCESS | 23443 | 02:36:58 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45065/tests/dromaeo/cssquery-mootools.html) 02:36:59 INFO - PROCESS | 23443 | RSS: Main: 225890304 02:36:59 INFO - PROCESS | 23443 | 02:40:01 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45065/tests/dromaeo/cssquery-prototype.html) 02:40:02 INFO - PROCESS | 23443 | RSS: Main: 223629312 02:40:02 INFO - PROCESS | 23443 | 02:43:04 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45065/tests/dromaeo/cssquery-yui.html) 02:43:05 INFO - PROCESS | 23443 | RSS: Main: 218755072 02:43:05 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | Cycle 1(1): loaded http://localhost:45065/tests/dromaeo/cssquery-yui.html (next: http://localhost:45065/tests/dromaeo/cssquery-dojo.html) 02:46:07 INFO - PROCESS | 23443 | RSS: Main: 251740160 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | __start_tp_report 02:46:07 INFO - PROCESS | 23443 | _x_x_mozilla_page_load 02:46:07 INFO - PROCESS | 23443 | _x_x_mozilla_page_load_details 02:46:07 INFO - PROCESS | 23443 | |i|pagename|runs| 02:46:07 INFO - PROCESS | 23443 | |0;dojo.html;3357.2446199605083;3374.460086386177;3386.8475918583663;3414.248865249644;3440.3463341965025;5646.774129034839;5730.226419433376;5741.598088133832;5749.137629355593;5765.7693692252315;5679.062954612495;5721.170430287616;5723.2559767230205;5736.483716465517;5746.569007324447;5048.1165795985735;5145.614078944075;5203.089459344618;5218.530332270095;5263.1578947368425;5114.002769459957;5223.2165175223645;5269.947300527003;5275.736213189344;5277;5139.897202055957;5166.948330516684;5175.171972484403;5191.506806853343;5217.843464696065;5244.449332820056;5266.368035835724;5269.209618557228;5274.894502109974;5299.099153143936;5020.071286811952;5129.948700512984;5146.9485305146845;5159;5185.5333020028;5572.442755724395;5583.8604034899045;5591.161325801122;5600.439956004408;5635.09838425854;6179.3202747697715;6182.598131121463;6182.783602573888;6186.536009799238;6192.81421557354;6125.632462052291;6159;6174.135621013062;6203.2245969253845;6259.843503912439;5803.274590676166;5814.854628634275;5837.737301821428;5841.474267315962;5853.29760428747;6034.064719968412;6338.936610633927;6352.7141278642575;6364.236291645032;6381.23425188971;6111.755529778848;6126.403259957709;6127.601705889103;6142.477889379364;6142.713648198282;6192.59748116371;6197.287311959182;6204.5967012144065;6214.9689251553455;6232.376762323822;5939.10913362999;6044.1840351552855;6193.721282542297;6198.0702894566175;6213.689315534296;6118.632882027093;6139.324674285825;6146.108814222002;6160.322364539897;6161.84595385119;4647.930281045787;4680.976595117003;4683.1336202802595;4701.670883038223;4738.099761045391;4099.221147981874;4151.107511884959;4155.314373128461;4184.623383895464;4198.1393814268;5932.822015339547;5943.3462319144855;5943.435373639497;5955.374685657944;5980.342162362137;6257.311695713468;6294.779682711083;6321.399467050623;6331.145295385064;6334.651594162366;5716.885662286731;5773.797917072882;5804.738786754606;5835.2122463466885;5914.349421563625;5315.548178404879;5316.707581083;5316.893662126736;5319.9202011969855;5320.627556071116;6399.9360006400275;6417;6424.357564243632;6424.38968298011;6429.967850160813;5943.375945525658;6050.878982420239;6069.939300606938;6081.422264884829;6176.042713379254;6337.334579869047;6373.649449280334;6379.393957574023;6382.6170429774365;6383.585066970632;5918.881622367442;6026.578139530191;6041.365656606169;6052.303985041776;6059.697015149313;6119.654885717031;6171.105189747551;6194.287656919512;6250.281217659845;6258.405451482102;6079.635221886701;6090.390960903874;6094.299155596986;6095.3904609538695;6108.144859719554;5821.243238378984;5845.240118784531;6057.454829065229;6093.6039157454625;6100.450959413496;5761.308642962871;5816.214811000461;5839.8832023358445;5859.589828711949;5882.441168089024;6001.459868611846;6016.2479690038745;6036.879262414815;6037.698115094316;6043.8186854394435;5789.073748200436;5880.235569375954;5895.557833162444;5902.970485147718;5922.615030023035 02:46:07 INFO - PROCESS | 23443 | |1;ext.html;600.1567797244873;650.5283669339728;663.6151032401208;670.4401824476563;672;33485.330293394116;36560.817195914016;36632;36716.632833671654;36788.632113678854;36758.632413675856;48442.75778621111;49158;49504.752476237656;53251;9150.130737579935;9297.070292970682;9315.813683726321;9323.720288391325;9324.487153206572;8612.612432440555;9174.17432431081;9324.067593240656;9325.393849399767;10911.781764364747;10985.835212471779;11129;11422.771544569103;11432;11461.36962467064;11213.607523736671;11319.094472442268;11331.09351251902;11356.545738170464;11361.14791390649;8441.282490988273;10903.236773425864;11074.224804263706;11290.322580645105;11309.321440713584;45033.54966450326;45476.77261613704;45507.08985820265;45510.31734523985;45538;3865.903352416184;3891.630295121959;3909.98045009776;4001.799910004517;4490.191765482212;35480;35738.64261357379;36062.819685901406;36129.277414451826;37092.81453592742;4764.785584648699;4781.665283430127;4785.3300537924715;4829.517048295177;4874.7082023263865;369962;371529;371588;371923.5615287679;372585;39148.21703565913;40179.59820401817;40713.38929916054;70876.29123708697;71723.64138179275;41998;42034;42045.36931946023;42436.1512769749;42437.78781106075;16206.189690515426;16536.421225257058;16543.751843722355;16558.337666493448;16564.83435165633;13528.255945922872;13701.657458563615;13708.040437169502;13709.520166794115;13723.656908577166;8935.195832375117;9080.954595227115;9350.111739384747;9497.097775711296;9508;3653.6529029742132;3660.633936606318;3664.5602527696847;3678.5953545110015;3694.150345420568;1086.4947799273375;1104.3815463340554;1121.506537123663;1121.7532142928542;1191.8510186226722;34764.82617586896;35202.47196292058;35286.64713352885;35290;35590;1164.959226427071;1191.2435603391734;1227.6010296653624;1297.896168306552;1338.1502745756516;18359.35742249015;18657.53356166107;18669.533261668294;18685.15916783748;18875.3393631225;578294;582135;582560;584406;584583;65181.34818651847;65821.34178658153;65823.67088164529;65842.67078664576;65957.6702116496;1334.1461464662623;1399.7200559888063;1412.039812927199;1444.4005737618982;1465.3552436927719;34198.82900585481;34371.31257374889;34587.30825383428;35066.474002890485;35886.820565897004;57822.4217757817;57885.421145788;58409;58473.70763146157;58484;330719;330799;331151;331190;331211;28055.57916631293;28072.438551228453;28360.85819570889;28567.714322856504;28754.993575224766;51917.22124168065;52838;53718.73140634272;54016.72991635017;54995.450045499034;43827.78086109549;44096.55903440925;44381.33427998647;44382.77808610936;44499.11001780011;43651.34522982221;44001;44319.77840110908;44846.3273050898;45714;44497.55502444934;44772.55227447814;44927;45093;45548.54451455443;37698.43452348272;40762.59237407588;41012.38481422721;41104.1779164421;41177.79411103045;29864.850675746482;30181;30446.84776576103;30628.693713062585;30803.84598077085 02:46:07 INFO - PROCESS | 23443 | |2;jquery.html;425.4596662238957;432.3087809086239;432.9004329004331;437.5558807810073;438.66223008283623;18431.44705658829;19395.224191032376;20430.89784551079;20439.080241389136;20451;19026.238950442;19433;19807.90096049518;19925.302614408498;19961.401157965283;5467.371252305996;5613.410591887854;5628.549716022729;5636.126400407943;5642.520385767215;5508;5512;5555.999920014396;5557.6109672322955;5821.417858214187;5826.592138550303;5849.415058494159;5884.941150588504;5889.204957330749;5896.321922978869;6442.16251887254;6601.768938087144;6608.735650573972;6628.5691430056895;6631.867362652744;5591.217229587861;5844.035734103868;5859.4140585941495;5931.258592675916;5937.7921772737745;14992.850071499364;15078.095314281069;15222.923885380613;20245.79754202454;24946.1268855591;2322.8141748660237;2385.6024695181404;2432.8540287582623;2486.316263027664;2508.4983003399393;10869.239153259276;10941.398223097727;11159.107271418266;11234.775304493945;11248;2060.6393881070753;2108.8312934965165;2143.6355819510723;2147.8281737460966;2183.2031308572414;62799;73978;75372.62313688452;76203;91883;10310.948445257876;11137.554497820158;11183.552657893755;11204.383758893176;11877.584284550172;15892.205389730698;16031.839681603034;16034.839651603568;16052.678946421007;16105.114218717848;8414.621342039623;8460.703875364332;8669.869951950726;8720.30237580992;8952.910470895338;8350.331973442231;8454.196851299239;8591.226789588842;8634.22291993711;8648.351373647001;5013.699178049329;5052.650517509376;5142.61430392722;5150.742462876841;5195.870103247449;1850.3061351993003;2056.9485762856048;2108.3253358925;2149.2370208576044;2161.265169842261;981.5337714585658;1022.3572066208785;1026.8870424253325;1036.2746077745608;1112.9871816646812;18903.24387024531;19279.4216173515;20108.597828043356;20147.59704805925;20320;996.1731762637139;1019.7399663085865;1037.8547003419376;1049.522467277387;1059.8304271316551;11030.393328366856;11440.656780296604;11486.712832179262;11559.884401156049;11567;496123;498669;504635;508379;526435;96011;96492.51753741187;96755.51622241843;97720.51139744397;98831;1086.842407850873;1114.4149321606221;1126.3242054767238;1128.4019469681245;1132.7564573616712;17782.199801009243;18062.819371806112;18074.367397141035;18186.09069546544;18278.81721182771;41860.790696047545;42535;42656.14687706166;43043.13913721645;43312.133757325304;55260;55365.723171383885;63051;64001;64582.354176459514;7329.047223860864;11549.48027338755;12445.875541244472;12474.563390281297;13715.862841371858;14966;15068.171250581323;15138.621534461287;15296.082235065931;15441.22793860325;12810.74378512406;12916.547920823103;13033.47866085384;13426.932865335611;13517.391717372939;9077.364584479023;9304;12706.618801435972;12733.808992865299;12835.101542891907;13228.735425291632;13510.121842080232;13516.459341626225;13716.725665486834;13728.725425491633;13203.339833008504;13436.529721459701;13661.453541858215;13670.52153174634;13983.580492585239;13288.800667989795;13524.459021639024;13533.593992180251;13583.864161358655;13739.175649460665 02:46:07 INFO - PROCESS | 23443 | |3;mootools.html;1420.36083762307;1586.159335552157;1606.2450648195347;1846.289178666213;1945.1149726874273;9345.626174952993;9708.902910970888;9737.951310243456;10070.496475176249;10072.748181295472;9827.459489728062;10046.196304295658;10057.547410366533;10085.394876307426;10098.444585547792;2143.8499305048654;2219.1678120704737;2221.3224966385246;2495.5133748918925;2542.1992072497196;2407.9157229496973;2514.585093459577;2515.220281712666;2517.773400393964;2532.316274605855;2507.5862482690336;2507.5862482690427;2537.175417989152;2579.6259542366347;2582.1866112174603;2104.736907886514;2190.7809219077963;2512.660790793247;2540.3776074861594;2542.148380292604;2283.303592404316;2512.346789834656;2614.633951246827;2615.6207349934343;2615.9607605885926;9555.617775289049;9596.616135354578;9600;9604.75988100303;9619;5435;5536.2249285100115;5536.557075433956;5542.224088627595;5544.3346798384455;3438.5873695156492;3521.295740851814;3531.7527773055895;3636;3637.7271704621994;1133.9886601134049;1168.649405178443;1201.195199216527;1213.1992884696058;1213.7147770273978;13546.051776375658;13721.039527233097;13759.79360309596;13763.243021633907;13787.931060344734;5097.541221290102;5239.816606418757;5315;5317.654352467077;5326.946730532645;12052.276863388224;12100.939495302468;12107.152499325139;12113.15207935436;12114.15200935926;5957.940420595739;5959;5967.254093238345;5970.014947533695;5973.790917317873;4768.737719425396;5189.558887494605;5272.657277276965;5350.0904846176245;5397.460253974649;4180.331147016524;4225.492940847118;4291.935620965688;4301.41930839339;4328.5455027222315;1218.6405010521917;1237.9504819807287;1251.8748125187408;1252.511520507003;1255.3033066648097;876.6624849433014;927.8840144981878;1022.9054911245045;1080.1574771678104;1093.983590246131;6597.274299827015;6646;6693.665316734144;6706.765263215764;6717.865642687118;474.2577865640262;484.10440684732964;484.1140712496124;485.5799733230801;488.70189184597365;4500.234960056733;4572.0855828834365;4593.311003349458;4661.184292748755;4712.740799256006;11701.765964680659;11982.760344793056;12402.503899843905;12450.81323780144;12455.128141030222;11675;11751.118666100077;11765.176437649454;11765.941170294265;11825.349605771766;8921.821563568692;8940.552972351357;8991.955040224626;9050.366474346733;9078.773030674285;6372.553921225655;6403.487720982217;6443.420092191538;6508.674566271573;6551.246606640298;10693.679189624323;10946.890531094587;11029.779404411707;11109.055730262695;11181.32912025281;10822.729431764268;11445.084393248686;11445.370504622326;11557.24877882935;11564.653060407865;7605.46761726696;8414.873776893473;8506.957465212881;8709.172628600272;8843.425177363708;9721.222302215665;9831.655892043744;9873.308868379145;9898.752531186778;9932.900670993487;8602.483850968962;8835.469871807712;8838.381313308008;8916.465012099296;8962.32782541299;8142.51144931306;8259.339252859876;8650.870236946324;8673.089325620718;8677.956610216908;7990.28087472107;8003.079645840803;8077.515349079074;8077.7576672699915;8080.797980050545;5851.473367396955;6019.277686677627;6038.094285857156;6084.087386891824;6130.47890929276;5897.941020589739;5905.055191169392;6007.699615019319;6010.278766548042;6463.838404039937 02:46:07 INFO - PROCESS | 23443 | |4;prototype.html;348.2738490247833;355.3337492202121;357.71382893685046;362.9655182757637;363.4747789444254;5591.518247664372;5657;5673.914891276624;5686.090225563906;5698.7435565399555;5536.806211782588;5580;5628.409017053212;5656.2929633795775;5697.4302569743;4264.7845364071245;4352.673549483786;4370.32259999699;4402.955970440286;4430.335449682541;4290.828366865321;4363.367311739796;4374.825006999717;4393.890152746191;4414.97792511037;4339.869803905872;4341.5672827966855;4344.45694288214;4357.651387888977;4392.5827046430695;4123.505179378464;4329.199098166818;4342.934855977162;4348.869533913988;4381.649468042565;3828.712846536521;3829.157585331223;3831.5440132749654;3833.0225792422752;3834.6357096075826;5352.652077614982;5355.410904800468;5403.432639572867;5404.648697834628;5438.265834112423;4894.119058569456;4981.227909674007;4994.2009278515625;5000.549950504435;5062.924056139161;5836.445537673957;5850.76596936122;5852.356240813507;5856.560757943129;5865.413458654143;4211.7262377945335;4213.71481698082;4218.430511880888;4221.303484924983;4227.435848735957;5785.739641716133;5853.970730146322;5886.264216972879;6098.878022439526;6101.60339577926;4262.42457268271;4267.125239325931;4271.487421509439;4278.229918614617;4293.098449325614;4322.308430651081;4327.805248763813;4329.242382583036;4330.696851220448;4344.891377715519;4738.218193998021;4845.9030819383415;4868.782804298925;4880.41435027799;4927.7536123193695;5824.184614154022;5828.300603927556;5861.150133230658;5863.73613187399;5866.501347385435;1489.5680252726804;1504.99917554827;1511.863932246103;1513.0392200952474;1520.1715065289443;934.9948805034614;952.1525842000625;952.8570714392896;973.9967833131885;974.0746291023414;5032.245163225545;5038.715127642501;5049.57078648319;5081.695098294114;5123.308353372322;5331.920021199685;5335.413104558495;5343.7862485500145;5356.223347614574;5361.865953351197;4881.560659540658;4991.700497970133;5017.272495488134;5019;5056.797728090835;2853.4578430098213;2864.1693908766642;2866.1974647098846;2870.8277503349864;2871.55490898911;5244.344456942882;5497.862553436196;5522.723863806794;5561.165825126263;5565.972170139124;5371;5376.435474275223;5407.432219616883;5484.945150548523;5492.642978206404;5405.675559509448;5441.537469314994;5491.313585801775;5513.531349835309;5552.222688823568;5199.974000129975;5262.394824595221;5338;5753.913691294718;6150.892839288792;6068.935187730168;6080.391960803884;6082.878342433215;6099.627583793611;6101.932161871743;5987.520998320037;6048.516118710405;6292.339304373158;6310.716017779119;6321.0834429008455;4289.163613095541;4309.83634418699;4320.589543993316;4350.434443522322;4354.825806967686;5811.27359080115;6060.484858787053;6091.482224011009;6097.4817140543555;6121.785737499166;5895.113563659588;5915.37888521699;5930.7924222652;5947.583669143291;5950.672713000827;5839.35767065614;5902.940970590239;5914.7338369774325;5926.318473375617;5926.614770039933;5579.525740312119;5761.596688231951;5776.729119593682;5794.652320860761;5805.680687562224;5845.941540584539;5916.184061280364;5927.792527261525;5949.791757288647;5975.133605627247;5682.886342273048;5686.545076393962;5809.186713860147;5827.737751801264;5837.591368604157 02:46:07 INFO - PROCESS | 23443 | |5;yui.html;655.3413819111792;697.4315932515;731.2979539641943;800.1838125112389;864.472671670281;16060;16970.660586788257;17023.914880425596;17128.14359282034;17373.218205180783;16311.918440407811;17021.148942552853;17046.403375881848;17623.206955686994;17640.735388969177;729.7117638532776;846.0524212881581;902.0348227396704;905.4295793649991;907.9455232686026;863.2921004776086;903.2954295649404;904.3579058868212;904.9999750275916;905.6151135767306;924.1082355526916;927.823713494434;928.8978212396631;929.5259417696956;929.5398777605095;754.0800223727044;896.3053633434075;918.3433844800933;918.9862152067691;922.3866129024191;683.1665368250726;684.4045680258157;684.6405637040543;684.9178098628147;684.9589024658536;16716.331346746116;16802.32790688371;16823.327066917307;16835.74746378805;16848.410305639245;14297.499587514387;14327.78508322376;14675.77986330206;14734.336954837057;14783.186924719135;13007.934960325138;13106.2136271824;13875.930620346935;13923.721525569432;14372;4075.32757095079;4178.6657067434835;4192.023663199132;4227.513835908849;4240.257954857919;76386;76799;78830.21169788286;80618.59690701509;80858;12450.501979920882;12653.746925061447;12662;12838.743225135631;12903.935480322538;22940.655890161663;22994.195203168143;23006.7699323008;23041;23104.422389440064;8877.245434138042;9117.179453849185;9325.114114159143;9335.253179745605;9417;5163.173892177234;5184.7407629618365;5218.399884013387;5225.843224703265;5302.496262855023;3732.701383889282;3894.279558281727;3903.0437542802197;3908.2378936107752;3913.8043097844993;667.2493444874516;680.550836447942;683.9247682754893;691.512483698991;700.870338987289;647.1069923505532;723.6707298179316;737.130186380066;745.8247311881703;796.5698522797741;10780;11014.559417623366;11156.609518666808;11160.776784464266;11209.327440353605;685.8101194427664;784.8508783331149;785.077533897668;800.8958835351367;814.7352110564091;5211.244369566468;5218.6868787872845;5381.273528073738;5387.407385187705;5408.648437851527;108030.45984770026;116539;116620.68554869658;116805.41597292128;116961.4151929252;66242;99000;100288.49855750674;102280;102342.48828755808;57729.422705772406;72801.2719872805;84506.5774671135;84662;85558.5722071398;10135.695929122137;10214;10436.16510679159;10710;10749;39261;44196.779016104716;46600.30099548442;52741;53068;68198.65900670465;68861;73111;73938;79334.6033269853;14041.438342466186;14316.427342906167;14323.212223327817;14337.78493322622;14484.493042743454;15954.521364359089;16220.756688649915;16512.174391280627;16517.752233716263;17154.571135721708;11479.560958841244;14078;14594.373012857788;14656.087027988191;14683.972121951361;14789.186594737394;15085.622859428164;15133.924330378277;15245;15436.382544698086;14602.561923142322;14697.55907322782;14790.556283311518;14794.704105918037;15027.624309392353;11814.527418903148;11898.58354957607;12233.143679942319;12294.75410491803;12729.26402592836;12503.499860005499;12550;12731.681707957376;12742.61772146837;12760.808587871375 02:46:07 INFO - PROCESS | 23443 | __end_tp_report 02:46:07 INFO - PROCESS | 23443 | __start_cc_report 02:46:07 INFO - PROCESS | 23443 | _x_x_mozilla_cycle_collect,911 02:46:07 INFO - PROCESS | 23443 | __end_cc_report 02:46:07 INFO - PROCESS | 23443 | __startTimestamp1465292767857__endTimestamp 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | ------- Summary: start ------- 02:46:07 INFO - PROCESS | 23443 | Number of tests: 6 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#0] dojo.html Cycles:165 Average:5716.39 Median:5922.62 stddev:657.27 (11.1%) stddev-sans-first:632.69 02:46:07 INFO - PROCESS | 23443 | Values: 3357.2 3374.5 3386.8 3414.2 3440.3 5646.8 5730.2 5741.6 5749.1 5765.8 5679.1 5721.2 5723.3 5736.5 5746.6 5048.1 5145.6 5203.1 5218.5 5263.2 5114.0 5223.2 5269.9 5275.7 5277.0 5139.9 5166.9 5175.2 5191.5 5217.8 5244.4 5266.4 5269.2 5274.9 5299.1 5020.1 5129.9 5146.9 5159.0 5185.5 5572.4 5583.9 5591.2 5600.4 5635.1 6179.3 6182.6 6182.8 6186.5 6192.8 6125.6 6159.0 6174.1 6203.2 6259.8 5803.3 5814.9 5837.7 5841.5 5853.3 6034.1 6338.9 6352.7 6364.2 6381.2 6111.8 6126.4 6127.6 6142.5 6142.7 6192.6 6197.3 6204.6 6215.0 6232.4 5939.1 6044.2 6193.7 6198.1 6213.7 6118.6 6139.3 6146.1 6160.3 6161.8 4647.9 4681.0 4683.1 4701.7 4738.1 4099.2 4151.1 4155.3 4184.6 4198.1 5932.8 5943.3 5943.4 5955.4 5980.3 6257.3 6294.8 6321.4 6331.1 6334.7 5716.9 5773.8 5804.7 5835.2 5914.3 5315.5 5316.7 5316.9 5319.9 5320.6 6399.9 6417.0 6424.4 6424.4 6430.0 5943.4 6050.9 6069.9 6081.4 6176.0 6337.3 6373.6 6379.4 6382.6 6383.6 5918.9 6026.6 6041.4 6052.3 6059.7 6119.7 6171.1 6194.3 6250.3 6258.4 6079.6 6090.4 6094.3 6095.4 6108.1 5821.2 5845.2 6057.5 6093.6 6100.5 5761.3 5816.2 5839.9 5859.6 5882.4 6001.5 6016.2 6036.9 6037.7 6043.8 5789.1 5880.2 5895.6 5903.0 5922.6 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#1] ext.html Cycles:180 Average:59774.85 Median:205141.72 stddev:117435.16 (57.2%) stddev-sans-first:117680.56 02:46:07 INFO - PROCESS | 23443 | Values: 600.2 650.5 663.6 670.4 672.0 33485.3 36560.8 36632.0 36716.6 36788.6 36758.6 48442.8 49158.0 49504.8 53251.0 9150.1 9297.1 9315.8 9323.7 9324.5 8612.6 9174.2 9324.1 9325.4 10911.8 10985.8 11129.0 11422.8 11432.0 11461.4 11213.6 11319.1 11331.1 11356.5 11361.1 8441.3 10903.2 11074.2 11290.3 11309.3 45033.5 45476.8 45507.1 45510.3 45538.0 3865.9 3891.6 3910.0 4001.8 4490.2 35480.0 35738.6 36062.8 36129.3 37092.8 4764.8 4781.7 4785.3 4829.5 4874.7 369962.0 371529.0 371588.0 371923.6 372585.0 39148.2 40179.6 40713.4 70876.3 71723.6 41998.0 42034.0 42045.4 42436.2 42437.8 16206.2 16536.4 16543.8 16558.3 16564.8 13528.3 13701.7 13708.0 13709.5 13723.7 8935.2 9081.0 9350.1 9497.1 9508.0 3653.7 3660.6 3664.6 3678.6 3694.2 1086.5 1104.4 1121.5 1121.8 1191.9 34764.8 35202.5 35286.6 35290.0 35590.0 1165.0 1191.2 1227.6 1297.9 1338.2 18359.4 18657.5 18669.5 18685.2 18875.3 578294.0 582135.0 582560.0 584406.0 584583.0 65181.3 65821.3 65823.7 65842.7 65957.7 1334.1 1399.7 1412.0 1444.4 1465.4 34198.8 34371.3 34587.3 35066.5 35886.8 57822.4 57885.4 58409.0 58473.7 58484.0 330719.0 330799.0 331151.0 331190.0 331211.0 28055.6 28072.4 28360.9 28567.7 28755.0 51917.2 52838.0 53718.7 54016.7 54995.5 43827.8 44096.6 44381.3 44382.8 44499.1 43651.3 44001.0 44319.8 44846.3 45714.0 44497.6 44772.6 44927.0 45093.0 45548.5 37698.4 40762.6 41012.4 41104.2 41177.8 29864.9 30181.0 30446.8 30628.7 30803.8 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#2] jquery.html Cycles:180 Average:30057.72 Median:2058.79 stddev:83457.76 (4053.7%) stddev-sans-first:83662.22 02:46:07 INFO - PROCESS | 23443 | Values: 425.5 432.3 432.9 437.6 438.7 18431.4 19395.2 20430.9 20439.1 20451.0 19026.2 19433.0 19807.9 19925.3 19961.4 5467.4 5613.4 5628.5 5636.1 5642.5 5508.0 5512.0 5556.0 5557.6 5821.4 5826.6 5849.4 5884.9 5889.2 5896.3 6442.2 6601.8 6608.7 6628.6 6631.9 5591.2 5844.0 5859.4 5931.3 5937.8 14992.9 15078.1 15222.9 20245.8 24946.1 2322.8 2385.6 2432.9 2486.3 2508.5 10869.2 10941.4 11159.1 11234.8 11248.0 2060.6 2108.8 2143.6 2147.8 2183.2 62799.0 73978.0 75372.6 76203.0 91883.0 10310.9 11137.6 11183.6 11204.4 11877.6 15892.2 16031.8 16034.8 16052.7 16105.1 8414.6 8460.7 8669.9 8720.3 8952.9 8350.3 8454.2 8591.2 8634.2 8648.4 5013.7 5052.7 5142.6 5150.7 5195.9 1850.3 2056.9 2108.3 2149.2 2161.3 981.5 1022.4 1026.9 1036.3 1113.0 18903.2 19279.4 20108.6 20147.6 20320.0 996.2 1019.7 1037.9 1049.5 1059.8 11030.4 11440.7 11486.7 11559.9 11567.0 496123.0 498669.0 504635.0 508379.0 526435.0 96011.0 96492.5 96755.5 97720.5 98831.0 1086.8 1114.4 1126.3 1128.4 1132.8 17782.2 18062.8 18074.4 18186.1 18278.8 41860.8 42535.0 42656.1 43043.1 43312.1 55260.0 55365.7 63051.0 64001.0 64582.4 7329.0 11549.5 12445.9 12474.6 13715.9 14966.0 15068.2 15138.6 15296.1 15441.2 12810.7 12916.5 13033.5 13426.9 13517.4 9077.4 9304.0 12706.6 12733.8 12835.1 13228.7 13510.1 13516.5 13716.7 13728.7 13203.3 13436.5 13661.5 13670.5 13983.6 13288.8 13524.5 13533.6 13583.9 13739.2 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#3] mootools.html Cycles:180 Average:6433.22 Median:4582.70 stddev:3749.59 (81.8%) stddev-sans-first:3741.18 02:46:07 INFO - PROCESS | 23443 | Values: 1420.4 1586.2 1606.2 1846.3 1945.1 9345.6 9708.9 9738.0 10070.5 10072.7 9827.5 10046.2 10057.5 10085.4 10098.4 2143.8 2219.2 2221.3 2495.5 2542.2 2407.9 2514.6 2515.2 2517.8 2532.3 2507.6 2507.6 2537.2 2579.6 2582.2 2104.7 2190.8 2512.7 2540.4 2542.1 2283.3 2512.3 2614.6 2615.6 2616.0 9555.6 9596.6 9600.0 9604.8 9619.0 5435.0 5536.2 5536.6 5542.2 5544.3 3438.6 3521.3 3531.8 3636.0 3637.7 1134.0 1168.6 1201.2 1213.2 1213.7 13546.1 13721.0 13759.8 13763.2 13787.9 5097.5 5239.8 5315.0 5317.7 5326.9 12052.3 12100.9 12107.2 12113.2 12114.2 5957.9 5959.0 5967.3 5970.0 5973.8 4768.7 5189.6 5272.7 5350.1 5397.5 4180.3 4225.5 4291.9 4301.4 4328.5 1218.6 1238.0 1251.9 1252.5 1255.3 876.7 927.9 1022.9 1080.2 1094.0 6597.3 6646.0 6693.7 6706.8 6717.9 474.3 484.1 484.1 485.6 488.7 4500.2 4572.1 4593.3 4661.2 4712.7 11701.8 11982.8 12402.5 12450.8 12455.1 11675.0 11751.1 11765.2 11765.9 11825.3 8921.8 8940.6 8992.0 9050.4 9078.8 6372.6 6403.5 6443.4 6508.7 6551.2 10693.7 10946.9 11029.8 11109.1 11181.3 10822.7 11445.1 11445.4 11557.2 11564.7 7605.5 8414.9 8507.0 8709.2 8843.4 9721.2 9831.7 9873.3 9898.8 9932.9 8602.5 8835.5 8838.4 8916.5 8962.3 8142.5 8259.3 8650.9 8673.1 8678.0 7990.3 8003.1 8077.5 8077.8 8080.8 5851.5 6019.3 6038.1 6084.1 6130.5 5897.9 5905.1 6007.7 6010.3 6463.8 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#4] prototype.html Cycles:180 Average:4809.16 Median:5366.43 stddev:1402.65 (26.1%) stddev-sans-first:1366.04 02:46:07 INFO - PROCESS | 23443 | Values: 348.3 355.3 357.7 363.0 363.5 5591.5 5657.0 5673.9 5686.1 5698.7 5536.8 5580.0 5628.4 5656.3 5697.4 4264.8 4352.7 4370.3 4403.0 4430.3 4290.8 4363.4 4374.8 4393.9 4415.0 4339.9 4341.6 4344.5 4357.7 4392.6 4123.5 4329.2 4342.9 4348.9 4381.6 3828.7 3829.2 3831.5 3833.0 3834.6 5352.7 5355.4 5403.4 5404.6 5438.3 4894.1 4981.2 4994.2 5000.5 5062.9 5836.4 5850.8 5852.4 5856.6 5865.4 4211.7 4213.7 4218.4 4221.3 4227.4 5785.7 5854.0 5886.3 6098.9 6101.6 4262.4 4267.1 4271.5 4278.2 4293.1 4322.3 4327.8 4329.2 4330.7 4344.9 4738.2 4845.9 4868.8 4880.4 4927.8 5824.2 5828.3 5861.2 5863.7 5866.5 1489.6 1505.0 1511.9 1513.0 1520.2 935.0 952.2 952.9 974.0 974.1 5032.2 5038.7 5049.6 5081.7 5123.3 5331.9 5335.4 5343.8 5356.2 5361.9 4881.6 4991.7 5017.3 5019.0 5056.8 2853.5 2864.2 2866.2 2870.8 2871.6 5244.3 5497.9 5522.7 5561.2 5566.0 5371.0 5376.4 5407.4 5484.9 5492.6 5405.7 5441.5 5491.3 5513.5 5552.2 5200.0 5262.4 5338.0 5753.9 6150.9 6068.9 6080.4 6082.9 6099.6 6101.9 5987.5 6048.5 6292.3 6310.7 6321.1 4289.2 4309.8 4320.6 4350.4 4354.8 5811.3 6060.5 6091.5 6097.5 6121.8 5895.1 5915.4 5930.8 5947.6 5950.7 5839.4 5902.9 5914.7 5926.3 5926.6 5579.5 5761.6 5776.7 5794.7 5805.7 5845.9 5916.2 5927.8 5949.8 5975.1 5682.9 5686.5 5809.2 5827.7 5837.6 02:46:07 INFO - PROCESS | 23443 | 02:46:07 INFO - PROCESS | 23443 | [#5] yui.html Cycles:180 Average:20982.54 Median:3905.64 stddev:28954.87 (741.4%) stddev-sans-first:28995.87 02:46:07 INFO - PROCESS | 23443 | Values: 655.3 697.4 731.3 800.2 864.5 16060.0 16970.7 17023.9 17128.1 17373.2 16311.9 17021.1 17046.4 17623.2 17640.7 729.7 846.1 902.0 905.4 907.9 863.3 903.3 904.4 905.0 905.6 924.1 927.8 928.9 929.5 929.5 754.1 896.3 918.3 919.0 922.4 683.2 684.4 684.6 684.9 685.0 16716.3 16802.3 16823.3 16835.7 16848.4 14297.5 14327.8 14675.8 14734.3 14783.2 13007.9 13106.2 13875.9 13923.7 14372.0 4075.3 4178.7 4192.0 4227.5 4240.3 76386.0 76799.0 78830.2 80618.6 80858.0 12450.5 12653.7 12662.0 12838.7 12903.9 22940.7 22994.2 23006.8 23041.0 23104.4 8877.2 9117.2 9325.1 9335.3 9417.0 5163.2 5184.7 5218.4 5225.8 5302.5 3732.7 3894.3 3903.0 3908.2 3913.8 667.2 680.6 683.9 691.5 700.9 647.1 723.7 737.1 745.8 796.6 10780.0 11014.6 11156.6 11160.8 11209.3 685.8 784.9 785.1 800.9 814.7 5211.2 5218.7 5381.3 5387.4 5408.6 108030.5 116539.0 116620.7 116805.4 116961.4 66242.0 99000.0 100288.5 102280.0 102342.5 57729.4 72801.3 84506.6 84662.0 85558.6 10135.7 10214.0 10436.2 10710.0 10749.0 39261.0 44196.8 46600.3 52741.0 53068.0 68198.7 68861.0 73111.0 73938.0 79334.6 14041.4 14316.4 14323.2 14337.8 14484.5 15954.5 16220.8 16512.2 16517.8 17154.6 11479.6 14078.0 14594.4 14656.1 14684.0 14789.2 15085.6 15133.9 15245.0 15436.4 14602.6 14697.6 14790.6 14794.7 15027.6 11814.5 11898.6 12233.1 12294.8 12729.3 12503.5 12550.0 12731.7 12742.6 12760.8 02:46:07 INFO - PROCESS | 23443 | -------- Summary: end -------- 02:46:07 INFO - PROCESS | 23443 | 02:46:08 INFO - TEST-INFO | 23443: exit 0 02:46:08 INFO - TEST-OK | dromaeo_css | took 1112699ms 02:46:08 INFO - TEST-START | kraken 02:46:08 INFO - operating with platform_type : linux_ 02:46:08 INFO - Initialising browser for kraken test... 02:46:08 INFO - TEST-INFO | started process 23635 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprK8mWm/profile http://localhost:45065/getInfo.html) 02:46:12 INFO - PROCESS | 23635 | __metrics Screen width/height:1600/1200 02:46:12 INFO - PROCESS | 23635 | colorDepth:24 02:46:12 INFO - PROCESS | 23635 | Browser inner width/height: 1024/697 02:46:12 INFO - PROCESS | 23635 | __metrics 02:46:13 ERROR - PROCESS | 23635 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:46:13 INFO - PROCESS | 23635 | console.error: PushService: 02:46:13 INFO - PROCESS | 23635 | stateChangeProcessEnqueue: Error transitioning state 02:46:13 INFO - PROCESS | 23635 | UnknownError 02:46:14 INFO - TEST-INFO | 23635: exit 0 02:46:14 INFO - Browser initialized. 02:46:14 INFO - Running cycle 1/1 for kraken test... 02:46:14 INFO - TEST-INFO | started process 23729 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprK8mWm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:46:26 INFO - PROCESS | 23729 | RSS: Main: 146001920 02:46:26 INFO - PROCESS | 23729 | 02:46:28 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45065/tests/kraken/driver.html?testName=audio-beat-detection) 02:46:29 INFO - PROCESS | 23729 | RSS: Main: 194760704 02:46:29 INFO - PROCESS | 23729 | 02:46:32 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45065/tests/kraken/driver.html?testName=audio-dft) 02:46:32 INFO - PROCESS | 23729 | RSS: Main: 193634304 02:46:32 INFO - PROCESS | 23729 | 02:46:35 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45065/tests/kraken/driver.html?testName=audio-fft) 02:46:36 INFO - PROCESS | 23729 | RSS: Main: 279879680 02:46:36 INFO - PROCESS | 23729 | 02:46:38 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45065/tests/kraken/driver.html?testName=audio-oscillator) 02:46:38 INFO - PROCESS | 23729 | RSS: Main: 188370944 02:46:38 INFO - PROCESS | 23729 | 02:46:40 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45065/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:46:41 INFO - PROCESS | 23729 | RSS: Main: 189014016 02:46:41 INFO - PROCESS | 23729 | 02:46:44 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45065/tests/kraken/driver.html?testName=imaging-darkroom) 02:46:45 INFO - PROCESS | 23729 | RSS: Main: 224100352 02:46:45 INFO - PROCESS | 23729 | 02:46:48 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45065/tests/kraken/driver.html?testName=imaging-desaturate) 02:46:49 INFO - PROCESS | 23729 | RSS: Main: 225239040 02:46:49 INFO - PROCESS | 23729 | 02:46:51 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45065/tests/kraken/driver.html?testName=json-parse-financial) 02:46:52 INFO - PROCESS | 23729 | RSS: Main: 223260672 02:46:52 INFO - PROCESS | 23729 | 02:46:54 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45065/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:46:54 INFO - PROCESS | 23729 | RSS: Main: 199344128 02:46:54 INFO - PROCESS | 23729 | 02:46:56 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:46:57 INFO - PROCESS | 23729 | RSS: Main: 202342400 02:46:57 INFO - PROCESS | 23729 | 02:46:59 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:46:59 INFO - PROCESS | 23729 | RSS: Main: 209260544 02:46:59 INFO - PROCESS | 23729 | 02:47:02 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:47:02 INFO - PROCESS | 23729 | RSS: Main: 216018944 02:47:02 INFO - PROCESS | 23729 | 02:47:05 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:47:06 INFO - PROCESS | 23729 | RSS: Main: 213446656 02:47:06 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | Cycle 1(1): loaded http://localhost:45065/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45065/tests/kraken/driver.html?testName=ai-astar) 02:47:07 INFO - PROCESS | 23729 | RSS: Main: 255549440 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | __start_tp_report 02:47:07 INFO - PROCESS | 23729 | _x_x_mozilla_page_load 02:47:07 INFO - PROCESS | 23729 | _x_x_mozilla_page_load_details 02:47:07 INFO - PROCESS | 23729 | |i|pagename|runs| 02:47:07 INFO - PROCESS | 23729 | |0;ai-astar;110;104;111;110;110;110;109;109;110;109 02:47:07 INFO - PROCESS | 23729 | |1;audio-beat-detection;149;126;129;178;124;127;151;130;153;124 02:47:07 INFO - PROCESS | 23729 | |2;audio-dft;161;162;160;160;162;161;160;161;161;161 02:47:07 INFO - PROCESS | 23729 | |3;audio-fft;75;74;74;133;76;76;75;75;103;74 02:47:07 INFO - PROCESS | 23729 | |4;audio-oscillator;84;84;119;85;84;85;111;84;85;129 02:47:07 INFO - PROCESS | 23729 | |5;imaging-gaussian-blur;117;116;116;117;116;117;117;117;116;117 02:47:07 INFO - PROCESS | 23729 | |6;imaging-darkroom;146;146;146;146;147;147;145;146;146;146 02:47:07 INFO - PROCESS | 23729 | |7;imaging-desaturate;94;95;95;94;95;95;94;95;95;94 02:47:07 INFO - PROCESS | 23729 | |8;json-parse-financial;51;51;53;52;52;53;53;53;52;51 02:47:07 INFO - PROCESS | 23729 | |9;json-stringify-tinderbox;59;60;59;59;59;60;59;59;59;59 02:47:07 INFO - PROCESS | 23729 | |10;stanford-crypto-aes;75;80;78;75;82;76;77;76;118;76 02:47:07 INFO - PROCESS | 23729 | |11;stanford-crypto-ccm;123;119;143;116;115;118;117;120;121;117 02:47:07 INFO - PROCESS | 23729 | |12;stanford-crypto-pbkdf2;155;159;154;159;153;152;157;158;152;154 02:47:07 INFO - PROCESS | 23729 | |13;stanford-crypto-sha256-iterative;62;71;61;61;60;61;60;60;60;63 02:47:07 INFO - PROCESS | 23729 | __end_tp_report 02:47:07 INFO - PROCESS | 23729 | __start_cc_report 02:47:07 INFO - PROCESS | 23729 | _x_x_mozilla_cycle_collect,1577 02:47:07 INFO - PROCESS | 23729 | __end_cc_report 02:47:07 INFO - PROCESS | 23729 | __startTimestamp1465292827903__endTimestamp 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | ------- Summary: start ------- 02:47:07 INFO - PROCESS | 23729 | Number of tests: 14 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.00 stddev:1.93 (1.8%) stddev-sans-first:2.03 02:47:07 INFO - PROCESS | 23729 | Values: 110.0 104.0 111.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#1] audio-beat-detection Cycles:10 Average:139.10 Median:139.50 stddev:17.97 (12.9%) stddev-sans-first:18.69 02:47:07 INFO - PROCESS | 23729 | Values: 149.0 126.0 129.0 178.0 124.0 127.0 151.0 130.0 153.0 124.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 02:47:07 INFO - PROCESS | 23729 | Values: 161.0 162.0 160.0 160.0 162.0 161.0 160.0 161.0 161.0 161.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#3] audio-fft Cycles:10 Average:83.50 Median:75.00 stddev:19.52 (26.0%) stddev-sans-first:20.46 02:47:07 INFO - PROCESS | 23729 | Values: 75.0 74.0 74.0 133.0 76.0 76.0 75.0 75.0 103.0 74.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#4] audio-oscillator Cycles:10 Average:95.00 Median:84.00 stddev:17.55 (20.9%) stddev-sans-first:18.16 02:47:07 INFO - PROCESS | 23729 | Values: 84.0 84.0 119.0 85.0 84.0 85.0 111.0 84.0 85.0 129.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 02:47:07 INFO - PROCESS | 23729 | Values: 117.0 116.0 116.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.57 (0.4%) stddev-sans-first:0.60 02:47:07 INFO - PROCESS | 23729 | Values: 146.0 146.0 146.0 146.0 147.0 147.0 145.0 146.0 146.0 146.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:95.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 02:47:07 INFO - PROCESS | 23729 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 94.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.83 02:47:07 INFO - PROCESS | 23729 | Values: 51.0 51.0 53.0 52.0 52.0 53.0 53.0 53.0 52.0 51.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#9] json-stringify-tinderbox Cycles:10 Average:59.20 Median:59.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 02:47:07 INFO - PROCESS | 23729 | Values: 59.0 60.0 59.0 59.0 59.0 60.0 59.0 59.0 59.0 59.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:76.50 stddev:13.09 (17.1%) stddev-sans-first:13.68 02:47:07 INFO - PROCESS | 23729 | Values: 75.0 80.0 78.0 75.0 82.0 76.0 77.0 76.0 118.0 76.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#11] stanford-crypto-ccm Cycles:10 Average:120.90 Median:119.50 stddev:8.13 (6.8%) stddev-sans-first:8.59 02:47:07 INFO - PROCESS | 23729 | Values: 123.0 119.0 143.0 116.0 115.0 118.0 117.0 120.0 121.0 117.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:155.30 Median:156.00 stddev:2.75 (1.8%) stddev-sans-first:2.92 02:47:07 INFO - PROCESS | 23729 | Values: 155.0 159.0 154.0 159.0 153.0 152.0 157.0 158.0 152.0 154.0 02:47:07 INFO - PROCESS | 23729 | 02:47:07 INFO - PROCESS | 23729 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.90 Median:61.00 stddev:3.35 (5.5%) stddev-sans-first:3.55 02:47:07 INFO - PROCESS | 23729 | Values: 62.0 71.0 61.0 61.0 60.0 61.0 60.0 60.0 60.0 63.0 02:47:07 INFO - PROCESS | 23729 | -------- Summary: end -------- 02:47:07 INFO - PROCESS | 23729 | 02:47:08 INFO - TEST-INFO | 23729: exit 0 02:47:08 INFO - TEST-OK | kraken | took 60278ms 02:47:08 INFO - SUITE-END | took 1172s 02:47:09 INFO - Completed test suite (00:19:33) 02:47:09 INFO - javascript benchmark 02:47:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.2446199605083, 3374.460086386177, 3386.8475918583663, 3414.248865249644, 3440.3463341965025, 5646.774129034839, 5730.226419433376, 5741.598088133832, 5749.137629355593, 5765.7693692252315, 5679.062954612495, 5721.170430287616, 5723.2559767230205, 5736.483716465517, 5746.569007324447, 5048.1165795985735, 5145.614078944075, 5203.089459344618, 5218.530332270095, 5263.1578947368425, 5114.002769459957, 5223.2165175223645, 5269.947300527003, 5275.736213189344, 5277.0, 5139.897202055957, 5166.948330516684, 5175.171972484403, 5191.506806853343, 5217.843464696065, 5244.449332820056, 5266.368035835724, 5269.209618557228, 5274.894502109974, 5299.099153143936, 5020.071286811952, 5129.948700512984, 5146.9485305146845, 5159.0, 5185.5333020028, 5572.442755724395, 5583.8604034899045, 5591.161325801122, 5600.439956004408, 5635.09838425854, 6179.3202747697715, 6182.598131121463, 6182.783602573888, 6186.536009799238, 6192.81421557354, 6125.632462052291, 6159.0, 6174.135621013062, 6203.2245969253845, 6259.843503912439, 5803.274590676166, 5814.854628634275, 5837.737301821428, 5841.474267315962, 5853.29760428747, 6034.064719968412, 6338.936610633927, 6352.7141278642575, 6364.236291645032, 6381.23425188971, 6111.755529778848, 6126.403259957709, 6127.601705889103, 6142.477889379364, 6142.713648198282, 6192.59748116371, 6197.287311959182, 6204.5967012144065, 6214.9689251553455, 6232.376762323822, 5939.10913362999, 6044.1840351552855, 6193.721282542297, 6198.0702894566175, 6213.689315534296, 6118.632882027093, 6139.324674285825, 6146.108814222002, 6160.322364539897, 6161.84595385119, 4647.930281045787, 4680.976595117003, 4683.1336202802595, 4701.670883038223, 4738.099761045391, 4099.221147981874, 4151.107511884959, 4155.314373128461, 4184.623383895464, 4198.1393814268, 5932.822015339547, 5943.3462319144855, 5943.435373639497, 5955.374685657944, 5980.342162362137, 6257.311695713468, 6294.779682711083, 6321.399467050623, 6331.145295385064, 6334.651594162366, 5716.885662286731, 5773.797917072882, 5804.738786754606, 5835.2122463466885, 5914.349421563625, 5315.548178404879, 5316.707581083, 5316.893662126736, 5319.9202011969855, 5320.627556071116, 6399.9360006400275, 6417.0, 6424.357564243632, 6424.38968298011, 6429.967850160813, 5943.375945525658, 6050.878982420239, 6069.939300606938, 6081.422264884829, 6176.042713379254, 6337.334579869047, 6373.649449280334, 6379.393957574023, 6382.6170429774365, 6383.585066970632, 5918.881622367442, 6026.578139530191, 6041.365656606169, 6052.303985041776, 6059.697015149313, 6119.654885717031, 6171.105189747551, 6194.287656919512, 6250.281217659845, 6258.405451482102, 6079.635221886701, 6090.390960903874, 6094.299155596986, 6095.3904609538695, 6108.144859719554, 5821.243238378984, 5845.240118784531, 6057.454829065229, 6093.6039157454625, 6100.450959413496, 5761.308642962871, 5816.214811000461, 5839.8832023358445, 5859.589828711949, 5882.441168089024, 6001.459868611846, 6016.2479690038745, 6036.879262414815, 6037.698115094316, 6043.8186854394435, 5789.073748200436, 5880.235569375954, 5895.557833162444, 5902.970485147718, 5922.615030023035], "value": 5672.035091467584, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [600.1567797244873, 650.5283669339728, 663.6151032401208, 670.4401824476563, 672.0, 33485.330293394116, 36560.817195914016, 36632.0, 36716.632833671654, 36788.632113678854, 36758.632413675856, 48442.75778621111, 49158.0, 49504.752476237656, 53251.0, 9150.130737579935, 9297.070292970682, 9315.813683726321, 9323.720288391325, 9324.487153206572, 8612.612432440555, 9174.17432431081, 9324.067593240656, 9325.393849399767, 10911.781764364747, 10985.835212471779, 11129.0, 11422.771544569103, 11432.0, 11461.36962467064, 11213.607523736671, 11319.094472442268, 11331.09351251902, 11356.545738170464, 11361.14791390649, 8441.282490988273, 10903.236773425864, 11074.224804263706, 11290.322580645105, 11309.321440713584, 45033.54966450326, 45476.77261613704, 45507.08985820265, 45510.31734523985, 45538.0, 3865.903352416184, 3891.630295121959, 3909.98045009776, 4001.799910004517, 4490.191765482212, 35480.0, 35738.64261357379, 36062.819685901406, 36129.277414451826, 37092.81453592742, 4764.785584648699, 4781.665283430127, 4785.3300537924715, 4829.517048295177, 4874.7082023263865, 369962.0, 371529.0, 371588.0, 371923.5615287679, 372585.0, 39148.21703565913, 40179.59820401817, 40713.38929916054, 70876.29123708697, 71723.64138179275, 41998.0, 42034.0, 42045.36931946023, 42436.1512769749, 42437.78781106075, 16206.189690515426, 16536.421225257058, 16543.751843722355, 16558.337666493448, 16564.83435165633, 13528.255945922872, 13701.657458563615, 13708.040437169502, 13709.520166794115, 13723.656908577166, 8935.195832375117, 9080.954595227115, 9350.111739384747, 9497.097775711296, 9508.0, 3653.6529029742132, 3660.633936606318, 3664.5602527696847, 3678.5953545110015, 3694.150345420568, 1086.4947799273375, 1104.3815463340554, 1121.506537123663, 1121.7532142928542, 1191.8510186226722, 34764.82617586896, 35202.47196292058, 35286.64713352885, 35290.0, 35590.0, 1164.959226427071, 1191.2435603391734, 1227.6010296653624, 1297.896168306552, 1338.1502745756516, 18359.35742249015, 18657.53356166107, 18669.533261668294, 18685.15916783748, 18875.3393631225, 578294.0, 582135.0, 582560.0, 584406.0, 584583.0, 65181.34818651847, 65821.34178658153, 65823.67088164529, 65842.67078664576, 65957.6702116496, 1334.1461464662623, 1399.7200559888063, 1412.039812927199, 1444.4005737618982, 1465.3552436927719, 34198.82900585481, 34371.31257374889, 34587.30825383428, 35066.474002890485, 35886.820565897004, 57822.4217757817, 57885.421145788, 58409.0, 58473.70763146157, 58484.0, 330719.0, 330799.0, 331151.0, 331190.0, 331211.0, 28055.57916631293, 28072.438551228453, 28360.85819570889, 28567.714322856504, 28754.993575224766, 51917.22124168065, 52838.0, 53718.73140634272, 54016.72991635017, 54995.450045499034, 43827.78086109549, 44096.55903440925, 44381.33427998647, 44382.77808610936, 44499.11001780011, 43651.34522982221, 44001.0, 44319.77840110908, 44846.3273050898, 45714.0, 44497.55502444934, 44772.55227447814, 44927.0, 45093.0, 45548.54451455443, 37698.43452348272, 40762.59237407588, 41012.38481422721, 41104.1779164421, 41177.79411103045, 29864.850675746482, 30181.0, 30446.84776576103, 30628.693713062585, 30803.84598077085], "value": 20425.38847408512, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [425.4596662238957, 432.3087809086239, 432.9004329004331, 437.5558807810073, 438.66223008283623, 18431.44705658829, 19395.224191032376, 20430.89784551079, 20439.080241389136, 20451.0, 19026.238950442, 19433.0, 19807.90096049518, 19925.302614408498, 19961.401157965283, 5467.371252305996, 5613.410591887854, 5628.549716022729, 5636.126400407943, 5642.520385767215, 5508.0, 5512.0, 5555.999920014396, 5557.6109672322955, 5821.417858214187, 5826.592138550303, 5849.415058494159, 5884.941150588504, 5889.204957330749, 5896.321922978869, 6442.16251887254, 6601.768938087144, 6608.735650573972, 6628.5691430056895, 6631.867362652744, 5591.217229587861, 5844.035734103868, 5859.4140585941495, 5931.258592675916, 5937.7921772737745, 14992.850071499364, 15078.095314281069, 15222.923885380613, 20245.79754202454, 24946.1268855591, 2322.8141748660237, 2385.6024695181404, 2432.8540287582623, 2486.316263027664, 2508.4983003399393, 10869.239153259276, 10941.398223097727, 11159.107271418266, 11234.775304493945, 11248.0, 2060.6393881070753, 2108.8312934965165, 2143.6355819510723, 2147.8281737460966, 2183.2031308572414, 62799.0, 73978.0, 75372.62313688452, 76203.0, 91883.0, 10310.948445257876, 11137.554497820158, 11183.552657893755, 11204.383758893176, 11877.584284550172, 15892.205389730698, 16031.839681603034, 16034.839651603568, 16052.678946421007, 16105.114218717848, 8414.621342039623, 8460.703875364332, 8669.869951950726, 8720.30237580992, 8952.910470895338, 8350.331973442231, 8454.196851299239, 8591.226789588842, 8634.22291993711, 8648.351373647001, 5013.699178049329, 5052.650517509376, 5142.61430392722, 5150.742462876841, 5195.870103247449, 1850.3061351993003, 2056.9485762856048, 2108.3253358925, 2149.2370208576044, 2161.265169842261, 981.5337714585658, 1022.3572066208785, 1026.8870424253325, 1036.2746077745608, 1112.9871816646812, 18903.24387024531, 19279.4216173515, 20108.597828043356, 20147.59704805925, 20320.0, 996.1731762637139, 1019.7399663085865, 1037.8547003419376, 1049.522467277387, 1059.8304271316551, 11030.393328366856, 11440.656780296604, 11486.712832179262, 11559.884401156049, 11567.0, 496123.0, 498669.0, 504635.0, 508379.0, 526435.0, 96011.0, 96492.51753741187, 96755.51622241843, 97720.51139744397, 98831.0, 1086.842407850873, 1114.4149321606221, 1126.3242054767238, 1128.4019469681245, 1132.7564573616712, 17782.199801009243, 18062.819371806112, 18074.367397141035, 18186.09069546544, 18278.81721182771, 41860.790696047545, 42535.0, 42656.14687706166, 43043.13913721645, 43312.133757325304, 55260.0, 55365.723171383885, 63051.0, 64001.0, 64582.354176459514, 7329.047223860864, 11549.48027338755, 12445.875541244472, 12474.563390281297, 13715.862841371858, 14966.0, 15068.171250581323, 15138.621534461287, 15296.082235065931, 15441.22793860325, 12810.74378512406, 12916.547920823103, 13033.47866085384, 13426.932865335611, 13517.391717372939, 9077.364584479023, 9304.0, 12706.618801435972, 12733.808992865299, 12835.101542891907, 13228.735425291632, 13510.121842080232, 13516.459341626225, 13716.725665486834, 13728.725425491633, 13203.339833008504, 13436.529721459701, 13661.453541858215, 13670.52153174634, 13983.580492585239, 13288.800667989795, 13524.459021639024, 13533.593992180251, 13583.864161358655, 13739.175649460665], "value": 9823.21780379653, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1420.36083762307, 1586.159335552157, 1606.2450648195347, 1846.289178666213, 1945.1149726874273, 9345.626174952993, 9708.902910970888, 9737.951310243456, 10070.496475176249, 10072.748181295472, 9827.459489728062, 10046.196304295658, 10057.547410366533, 10085.394876307426, 10098.444585547792, 2143.8499305048654, 2219.1678120704737, 2221.3224966385246, 2495.5133748918925, 2542.1992072497196, 2407.9157229496973, 2514.585093459577, 2515.220281712666, 2517.773400393964, 2532.316274605855, 2507.5862482690336, 2507.5862482690427, 2537.175417989152, 2579.6259542366347, 2582.1866112174603, 2104.736907886514, 2190.7809219077963, 2512.660790793247, 2540.3776074861594, 2542.148380292604, 2283.303592404316, 2512.346789834656, 2614.633951246827, 2615.6207349934343, 2615.9607605885926, 9555.617775289049, 9596.616135354578, 9600.0, 9604.75988100303, 9619.0, 5435.0, 5536.2249285100115, 5536.557075433956, 5542.224088627595, 5544.3346798384455, 3438.5873695156492, 3521.295740851814, 3531.7527773055895, 3636.0, 3637.7271704621994, 1133.9886601134049, 1168.649405178443, 1201.195199216527, 1213.1992884696058, 1213.7147770273978, 13546.051776375658, 13721.039527233097, 13759.79360309596, 13763.243021633907, 13787.931060344734, 5097.541221290102, 5239.816606418757, 5315.0, 5317.654352467077, 5326.946730532645, 12052.276863388224, 12100.939495302468, 12107.152499325139, 12113.15207935436, 12114.15200935926, 5957.940420595739, 5959.0, 5967.254093238345, 5970.014947533695, 5973.790917317873, 4768.737719425396, 5189.558887494605, 5272.657277276965, 5350.0904846176245, 5397.460253974649, 4180.331147016524, 4225.492940847118, 4291.935620965688, 4301.41930839339, 4328.5455027222315, 1218.6405010521917, 1237.9504819807287, 1251.8748125187408, 1252.511520507003, 1255.3033066648097, 876.6624849433014, 927.8840144981878, 1022.9054911245045, 1080.1574771678104, 1093.983590246131, 6597.274299827015, 6646.0, 6693.665316734144, 6706.765263215764, 6717.865642687118, 474.2577865640262, 484.10440684732964, 484.1140712496124, 485.5799733230801, 488.70189184597365, 4500.234960056733, 4572.0855828834365, 4593.311003349458, 4661.184292748755, 4712.740799256006, 11701.765964680659, 11982.760344793056, 12402.503899843905, 12450.81323780144, 12455.128141030222, 11675.0, 11751.118666100077, 11765.176437649454, 11765.941170294265, 11825.349605771766, 8921.821563568692, 8940.552972351357, 8991.955040224626, 9050.366474346733, 9078.773030674285, 6372.553921225655, 6403.487720982217, 6443.420092191538, 6508.674566271573, 6551.246606640298, 10693.679189624323, 10946.890531094587, 11029.779404411707, 11109.055730262695, 11181.32912025281, 10822.729431764268, 11445.084393248686, 11445.370504622326, 11557.24877882935, 11564.653060407865, 7605.46761726696, 8414.873776893473, 8506.957465212881, 8709.172628600272, 8843.425177363708, 9721.222302215665, 9831.655892043744, 9873.308868379145, 9898.752531186778, 9932.900670993487, 8602.483850968962, 8835.469871807712, 8838.381313308008, 8916.465012099296, 8962.32782541299, 8142.51144931306, 8259.339252859876, 8650.870236946324, 8673.089325620718, 8677.956610216908, 7990.28087472107, 8003.079645840803, 8077.515349079074, 8077.7576672699915, 8080.797980050545, 5851.473367396955, 6019.277686677627, 6038.094285857156, 6084.087386891824, 6130.47890929276, 5897.941020589739, 5905.055191169392, 6007.699615019319, 6010.278766548042, 6463.838404039937], "value": 4987.15604346555, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.2738490247833, 355.3337492202121, 357.71382893685046, 362.9655182757637, 363.4747789444254, 5591.518247664372, 5657.0, 5673.914891276624, 5686.090225563906, 5698.7435565399555, 5536.806211782588, 5580.0, 5628.409017053212, 5656.2929633795775, 5697.4302569743, 4264.7845364071245, 4352.673549483786, 4370.32259999699, 4402.955970440286, 4430.335449682541, 4290.828366865321, 4363.367311739796, 4374.825006999717, 4393.890152746191, 4414.97792511037, 4339.869803905872, 4341.5672827966855, 4344.45694288214, 4357.651387888977, 4392.5827046430695, 4123.505179378464, 4329.199098166818, 4342.934855977162, 4348.869533913988, 4381.649468042565, 3828.712846536521, 3829.157585331223, 3831.5440132749654, 3833.0225792422752, 3834.6357096075826, 5352.652077614982, 5355.410904800468, 5403.432639572867, 5404.648697834628, 5438.265834112423, 4894.119058569456, 4981.227909674007, 4994.2009278515625, 5000.549950504435, 5062.924056139161, 5836.445537673957, 5850.76596936122, 5852.356240813507, 5856.560757943129, 5865.413458654143, 4211.7262377945335, 4213.71481698082, 4218.430511880888, 4221.303484924983, 4227.435848735957, 5785.739641716133, 5853.970730146322, 5886.264216972879, 6098.878022439526, 6101.60339577926, 4262.42457268271, 4267.125239325931, 4271.487421509439, 4278.229918614617, 4293.098449325614, 4322.308430651081, 4327.805248763813, 4329.242382583036, 4330.696851220448, 4344.891377715519, 4738.218193998021, 4845.9030819383415, 4868.782804298925, 4880.41435027799, 4927.7536123193695, 5824.184614154022, 5828.300603927556, 5861.150133230658, 5863.73613187399, 5866.501347385435, 1489.5680252726804, 1504.99917554827, 1511.863932246103, 1513.0392200952474, 1520.1715065289443, 934.9948805034614, 952.1525842000625, 952.8570714392896, 973.9967833131885, 974.0746291023414, 5032.245163225545, 5038.715127642501, 5049.57078648319, 5081.695098294114, 5123.308353372322, 5331.920021199685, 5335.413104558495, 5343.7862485500145, 5356.223347614574, 5361.865953351197, 4881.560659540658, 4991.700497970133, 5017.272495488134, 5019.0, 5056.797728090835, 2853.4578430098213, 2864.1693908766642, 2866.1974647098846, 2870.8277503349864, 2871.55490898911, 5244.344456942882, 5497.862553436196, 5522.723863806794, 5561.165825126263, 5565.972170139124, 5371.0, 5376.435474275223, 5407.432219616883, 5484.945150548523, 5492.642978206404, 5405.675559509448, 5441.537469314994, 5491.313585801775, 5513.531349835309, 5552.222688823568, 5199.974000129975, 5262.394824595221, 5338.0, 5753.913691294718, 6150.892839288792, 6068.935187730168, 6080.391960803884, 6082.878342433215, 6099.627583793611, 6101.932161871743, 5987.520998320037, 6048.516118710405, 6292.339304373158, 6310.716017779119, 6321.0834429008455, 4289.163613095541, 4309.83634418699, 4320.589543993316, 4350.434443522322, 4354.825806967686, 5811.27359080115, 6060.484858787053, 6091.482224011009, 6097.4817140543555, 6121.785737499166, 5895.113563659588, 5915.37888521699, 5930.7924222652, 5947.583669143291, 5950.672713000827, 5839.35767065614, 5902.940970590239, 5914.7338369774325, 5926.318473375617, 5926.614770039933, 5579.525740312119, 5761.596688231951, 5776.729119593682, 5794.652320860761, 5805.680687562224, 5845.941540584539, 5916.184061280364, 5927.792527261525, 5949.791757288647, 5975.133605627247, 5682.886342273048, 5686.545076393962, 5809.186713860147, 5827.737751801264, 5837.591368604157], "value": 4366.098199065846, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.3413819111792, 697.4315932515, 731.2979539641943, 800.1838125112389, 864.472671670281, 16060.0, 16970.660586788257, 17023.914880425596, 17128.14359282034, 17373.218205180783, 16311.918440407811, 17021.148942552853, 17046.403375881848, 17623.206955686994, 17640.735388969177, 729.7117638532776, 846.0524212881581, 902.0348227396704, 905.4295793649991, 907.9455232686026, 863.2921004776086, 903.2954295649404, 904.3579058868212, 904.9999750275916, 905.6151135767306, 924.1082355526916, 927.823713494434, 928.8978212396631, 929.5259417696956, 929.5398777605095, 754.0800223727044, 896.3053633434075, 918.3433844800933, 918.9862152067691, 922.3866129024191, 683.1665368250726, 684.4045680258157, 684.6405637040543, 684.9178098628147, 684.9589024658536, 16716.331346746116, 16802.32790688371, 16823.327066917307, 16835.74746378805, 16848.410305639245, 14297.499587514387, 14327.78508322376, 14675.77986330206, 14734.336954837057, 14783.186924719135, 13007.934960325138, 13106.2136271824, 13875.930620346935, 13923.721525569432, 14372.0, 4075.32757095079, 4178.6657067434835, 4192.023663199132, 4227.513835908849, 4240.257954857919, 76386.0, 76799.0, 78830.21169788286, 80618.59690701509, 80858.0, 12450.501979920882, 12653.746925061447, 12662.0, 12838.743225135631, 12903.935480322538, 22940.655890161663, 22994.195203168143, 23006.7699323008, 23041.0, 23104.422389440064, 8877.245434138042, 9117.179453849185, 9325.114114159143, 9335.253179745605, 9417.0, 5163.173892177234, 5184.7407629618365, 5218.399884013387, 5225.843224703265, 5302.496262855023, 3732.701383889282, 3894.279558281727, 3903.0437542802197, 3908.2378936107752, 3913.8043097844993, 667.2493444874516, 680.550836447942, 683.9247682754893, 691.512483698991, 700.870338987289, 647.1069923505532, 723.6707298179316, 737.130186380066, 745.8247311881703, 796.5698522797741, 10780.0, 11014.559417623366, 11156.609518666808, 11160.776784464266, 11209.327440353605, 685.8101194427664, 784.8508783331149, 785.077533897668, 800.8958835351367, 814.7352110564091, 5211.244369566468, 5218.6868787872845, 5381.273528073738, 5387.407385187705, 5408.648437851527, 108030.45984770026, 116539.0, 116620.68554869658, 116805.41597292128, 116961.4151929252, 66242.0, 99000.0, 100288.49855750674, 102280.0, 102342.48828755808, 57729.422705772406, 72801.2719872805, 84506.5774671135, 84662.0, 85558.5722071398, 10135.695929122137, 10214.0, 10436.16510679159, 10710.0, 10749.0, 39261.0, 44196.779016104716, 46600.30099548442, 52741.0, 53068.0, 68198.65900670465, 68861.0, 73111.0, 73938.0, 79334.6033269853, 14041.438342466186, 14316.427342906167, 14323.212223327817, 14337.78493322622, 14484.493042743454, 15954.521364359089, 16220.756688649915, 16512.174391280627, 16517.752233716263, 17154.571135721708, 11479.560958841244, 14078.0, 14594.373012857788, 14656.087027988191, 14683.972121951361, 14789.186594737394, 15085.622859428164, 15133.924330378277, 15245.0, 15436.382544698086, 14602.561923142322, 14697.55907322782, 14790.556283311518, 14794.704105918037, 15027.624309392353, 11814.527418903148, 11898.58354957607, 12233.143679942319, 12294.75410491803, 12729.26402592836, 12503.499860005499, 12550.0, 12731.681707957376, 12742.61772146837, 12760.808587871375], "value": 8065.402174601626, "unit": "score"}], "name": "dromaeo_css", "value": 7646.502891707658, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 104.0, 111.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 126.0, 129.0, 178.0, 124.0, 127.0, 151.0, 130.0, 153.0, 124.0], "value": 139.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0, 161.0, 161.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 133.0, 76.0, 76.0, 75.0, 75.0, 103.0, 74.0], "value": 83.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 119.0, 85.0, 84.0, 85.0, 111.0, 84.0, 85.0, 129.0], "value": 95.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 145.0, 146.0, 146.0, 146.0], "value": 146.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 51.0, 53.0, 52.0, 52.0, 53.0, 53.0, 53.0, 52.0, 51.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 59.0, 59.0, 60.0, 59.0, 59.0, 59.0, 59.0], "value": 59.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 78.0, 75.0, 82.0, 76.0, 77.0, 76.0, 118.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 119.0, 143.0, 116.0, 115.0, 118.0, 117.0, 120.0, 121.0, 117.0], "value": 120.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 159.0, 154.0, 159.0, 153.0, 152.0, 157.0, 158.0, 152.0, 154.0], "value": 155.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 71.0, 61.0, 61.0, 60.0, 61.0, 60.0, 60.0, 60.0, 63.0], "value": 61.9, "unit": "score"}], "name": "kraken", "value": 1475.7000000000003, "alertThreshold": 2.0}]} 02:47:09 INFO - Return code: 0 02:47:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:47:09 ERROR - # TBPL SUCCESS # 02:47:09 INFO - Running post-action listener: _resource_record_post_action 02:47:09 INFO - ##### 02:47:09 INFO - ##### Finished run-tests step (success) 02:47:09 INFO - ##### 02:47:09 INFO - Running post-run listener: _resource_record_post_run 02:47:09 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 266240; Write bytes: 505593856; Read time: 32; Write time: 414496 02:47:09 INFO - TinderboxPrint: CPU usage
13.1% 02:47:09 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 32 02:47:09 INFO - TinderboxPrint: I/O write bytes / time
505,593,856 / 414,496 02:47:09 INFO - TinderboxPrint: CPU idle
8,251.7 (86.9%) 02:47:09 INFO - TinderboxPrint: CPU user
1,200.8 (12.6%) 02:47:09 INFO - TinderboxPrint: Swap in / out
0 / 0 02:47:09 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 252321792; Read time: 0; Write time: 229092 02:47:09 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 266240; Write bytes: 253272064; Read time: 32; Write time: 185404 02:47:09 INFO - Running post-run listener: _upload_blobber_files 02:47:09 INFO - Blob upload gear active. 02:47:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:47:09 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:47:09 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:47:09 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:47:10 INFO - (blobuploader) - INFO - Open directory for files ... 02:47:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:47:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:47:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:11 INFO - (blobuploader) - INFO - Done attempting. 02:47:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:47:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:47:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:16 INFO - (blobuploader) - INFO - Done attempting. 02:47:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:47:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:47:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:47:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:47:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:47:17 INFO - (blobuploader) - INFO - Done attempting. 02:47:17 INFO - (blobuploader) - INFO - Iteration through files over. 02:47:17 INFO - Return code: 0 02:47:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:47:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:47:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be26e7a8012d123a04adbf2d0dc71ae2b8450ee1ccead89bd356370c099a6de84a8de46e7b301b814b64ee06e2fc56a297a4990d490c5fe8f87a37c319c2e41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac70075efb4a6500fb6489075b5b2c3b17e8b6a1530328061e7a6b2b9492a928cd08142bf7ec5b56709acfe14a93f60751792984eafd3489c200d4afdb909e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8e57e1c8c5913c6b4d9d5a402351e55b6beda3ede97ddbc56c603514f2e8beacebcaf02337117e9c57a10074e3b5005e7badce16285d800ff1142fbc1f44cf"} 02:47:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:47:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:47:17 INFO - Contents: 02:47:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be26e7a8012d123a04adbf2d0dc71ae2b8450ee1ccead89bd356370c099a6de84a8de46e7b301b814b64ee06e2fc56a297a4990d490c5fe8f87a37c319c2e41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac70075efb4a6500fb6489075b5b2c3b17e8b6a1530328061e7a6b2b9492a928cd08142bf7ec5b56709acfe14a93f60751792984eafd3489c200d4afdb909e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8e57e1c8c5913c6b4d9d5a402351e55b6beda3ede97ddbc56c603514f2e8beacebcaf02337117e9c57a10074e3b5005e7badce16285d800ff1142fbc1f44cf"} 02:47:17 INFO - Running post-run listener: copy_logs_to_upload_dir 02:47:17 INFO - Copying logs to upload dir... 02:47:17 INFO - mkdir: /builds/slave/test/build/upload/logs 02:47:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.924094 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-06-07 02:47:16.851101) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:16.855002) ========= 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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be26e7a8012d123a04adbf2d0dc71ae2b8450ee1ccead89bd356370c099a6de84a8de46e7b301b814b64ee06e2fc56a297a4990d490c5fe8f87a37c319c2e41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac70075efb4a6500fb6489075b5b2c3b17e8b6a1530328061e7a6b2b9492a928cd08142bf7ec5b56709acfe14a93f60751792984eafd3489c200d4afdb909e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8e57e1c8c5913c6b4d9d5a402351e55b6beda3ede97ddbc56c603514f2e8beacebcaf02337117e9c57a10074e3b5005e7badce16285d800ff1142fbc1f44cf"} 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.011351 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1be26e7a8012d123a04adbf2d0dc71ae2b8450ee1ccead89bd356370c099a6de84a8de46e7b301b814b64ee06e2fc56a297a4990d490c5fe8f87a37c319c2e41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ac70075efb4a6500fb6489075b5b2c3b17e8b6a1530328061e7a6b2b9492a928cd08142bf7ec5b56709acfe14a93f60751792984eafd3489c200d4afdb909e27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/dc8e57e1c8c5913c6b4d9d5a402351e55b6beda3ede97ddbc56c603514f2e8beacebcaf02337117e9c57a10074e3b5005e7badce16285d800ff1142fbc1f44cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:16.881638) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:16.882016) ========= 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=00204705a9daa57ed339a427000001b9-1465291598.135313-65303513 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004505 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 02:47:16.966962) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:47:16.967322) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 02:47:16.967738) ========= ========= Total master_lag: 0.18 =========