builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-016 starttime: 1461189495.77 results: success (0) buildid: 20160420135553 builduid: d3aa61ee81694221b6574211e5a5398e revision: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.772494) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.773103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.773488) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.828176) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.828491) ========= 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-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-04-20 14:58:15-- 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% 226M=0s 2016-04-20 14:58:15 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118681 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.982007) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:15.982292) ========= 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-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.103792 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.137145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.137499) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 93090fa3065335c9f830e9c70cbfbbc2f40fd979 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 93090fa3065335c9f830e9c70cbfbbc2f40fd979 --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-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-04-20 14:58:16,191 truncating revision to first 12 chars 2016-04-20 14:58:16,191 Setting DEBUG logging. 2016-04-20 14:58:16,191 attempt 1/10 2016-04-20 14:58:16,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/93090fa30653?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 14:58:16,455 unpacking tar archive at: mozilla-central-93090fa30653/testing/mozharness/ program finished with exit code 0 elapsedTime=0.582948 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.734836) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.735173) ========= script_repo_revision: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.735606) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.735878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 14:58:16.746108) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-20 14:58:16.746387) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:58:16 INFO - MultiFileLogger online at 20160420 14:58:16 in /builds/slave/test 14:58:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 14:58:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:58:16 INFO - {'append_to_log': False, 14:58:16 INFO - 'base_work_dir': '/builds/slave/test', 14:58:16 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 14:58:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:58:16 INFO - 'branch': 'Firefox-Non-PGO', 14:58:16 INFO - 'buildbot_json_path': 'buildprops.json', 14:58:16 INFO - 'config_files': ('talos/linux_config.py',), 14:58:16 INFO - 'default_actions': ('clobber', 14:58:16 INFO - 'read-buildbot-config', 14:58:16 INFO - 'download-and-extract', 14:58:16 INFO - 'populate-webroot', 14:58:16 INFO - 'create-virtualenv', 14:58:16 INFO - 'install', 14:58:16 INFO - 'run-tests'), 14:58:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:58:16 INFO - 'download_minidump_stackwalk': True, 14:58:16 INFO - 'download_symbols': 'ondemand', 14:58:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:58:16 INFO - 'tooltool.py': '/tools/tooltool.py', 14:58:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:58:16 INFO - '/tools/misc-python/virtualenv.py')}, 14:58:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:58:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:58:16 INFO - 'installer_path': 'installer.exe', 14:58:16 INFO - 'log_level': 'info', 14:58:16 INFO - 'log_name': 'talos', 14:58:16 INFO - 'log_to_console': True, 14:58:16 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:58:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:58:16 INFO - 'opt_config_files': (), 14:58:16 INFO - 'pip_index': False, 14:58:16 INFO - 'sps_profile': False, 14:58:16 INFO - 'sps_profile_interval': 0, 14:58:16 INFO - 'suite': 'dromaeojs', 14:58:16 INFO - 'system_bits': '32', 14:58:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:58:16 INFO - 'title': 'talos-linux64-ix-016', 14:58:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:58:16 INFO - 'use_talos_json': True, 14:58:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:58:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:58:16 INFO - 'work_dir': 'build'} 14:58:16 INFO - ##### 14:58:16 INFO - ##### Running clobber step. 14:58:16 INFO - ##### 14:58:16 INFO - Running pre-action listener: _resource_record_pre_action 14:58:16 INFO - Running main action method: clobber 14:58:16 INFO - rmtree: /builds/slave/test/build 14:58:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:58:17 INFO - Running post-action listener: _resource_record_post_action 14:58:17 INFO - ##### 14:58:17 INFO - ##### Running read-buildbot-config step. 14:58:17 INFO - ##### 14:58:17 INFO - Running pre-action listener: _resource_record_pre_action 14:58:17 INFO - Running main action method: read_buildbot_config 14:58:17 INFO - Using buildbot properties: 14:58:17 INFO - { 14:58:17 INFO - "project": "", 14:58:17 INFO - "product": "firefox", 14:58:17 INFO - "script_repo_revision": "production", 14:58:17 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 14:58:17 INFO - "repository": "", 14:58:17 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 14:58:17 INFO - "buildid": "20160420135553", 14:58:17 INFO - "pgo_build": "False", 14:58:17 INFO - "basedir": "/builds/slave/test", 14:58:17 INFO - "buildnumber": 479, 14:58:17 INFO - "slavename": "talos-linux64-ix-016", 14:58:17 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 14:58:17 INFO - "platform": "ubuntu64_hw", 14:58:17 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 14:58:17 INFO - "branch": "mozilla-central", 14:58:17 INFO - "repo_path": "mozilla-central", 14:58:17 INFO - "revision": "93090fa3065335c9f830e9c70cbfbbc2f40fd979", 14:58:17 INFO - "stage_platform": "linux64", 14:58:17 INFO - "builduid": "d3aa61ee81694221b6574211e5a5398e", 14:58:17 INFO - "slavebuilddir": "test" 14:58:17 INFO - } 14:58:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2. 14:58:17 INFO - Running post-action listener: _resource_record_post_action 14:58:17 INFO - ##### 14:58:17 INFO - ##### Running download-and-extract step. 14:58:17 INFO - ##### 14:58:17 INFO - Running pre-action listener: _resource_record_pre_action 14:58:17 INFO - Running main action method: download_and_extract 14:58:17 INFO - mkdir: /builds/slave/test/build/tests 14:58:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:17 INFO - https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 14:58:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:58:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:58:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:58:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:58:20 INFO - Downloaded 1361 bytes. 14:58:20 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.test_packages.json 14:58:20 INFO - Using the following test package requirements: 14:58:20 INFO - {u'common': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:20 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:58:20 INFO - u'gtest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:58:20 INFO - u'jittest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'jsshell-linux-x86_64.zip'], 14:58:20 INFO - u'mochitest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:58:20 INFO - u'mozbase': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'], 14:58:20 INFO - u'reftest': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:58:20 INFO - u'talos': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:58:20 INFO - u'web-platform': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:58:20 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 14:58:20 INFO - u'firefox-48.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:58:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:58:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:20 INFO - https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:58:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:22 INFO - Downloaded 22275272 bytes. 14:58:22 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:22 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:58:23 INFO - Return code: 0 14:58:23 INFO - Downloading packages: [u'firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:23 INFO - https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 14:58:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip 14:58:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:58:27 INFO - Downloaded 22275272 bytes. 14:58:27 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:27 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:58:28 INFO - Return code: 0 14:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:28 INFO - https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 14:58:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip 14:58:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:58:29 INFO - Downloaded 10845952 bytes. 14:58:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:58:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:58:29 INFO - Return code: 0 14:58:29 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')]} 14:58:29 INFO - https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 14:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:58:31 INFO - Downloaded 54602349 bytes. 14:58:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:58:31 INFO - mkdir: /builds/slave/test/properties 14:58:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:58:31 INFO - Writing to file /builds/slave/test/properties/build_url 14:58:31 INFO - Contents: 14:58:31 INFO - build_url:https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 14:58:31 INFO - Running post-action listener: _resource_record_post_action 14:58:31 INFO - Running post-action listener: set_extra_try_arguments 14:58:31 INFO - ##### 14:58:31 INFO - ##### Running populate-webroot step. 14:58:31 INFO - ##### 14:58:31 INFO - Running pre-action listener: _resource_record_pre_action 14:58:31 INFO - Running main action method: populate_webroot 14:58:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:58:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:58:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:58:31 INFO - '--tppagecycles', 14:58:31 INFO - '7'], 14:58:31 INFO - 'tests': ['tsvgm']}}, 14:58:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:58:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:58:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:58:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:58:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:58:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['damp', 'tps']}, 14:58:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'tests': ['damp', 'tps']}, 14:58:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['dromaeo_dom']}, 14:58:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:58:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'other-e10s': {'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['a11yr', 14:58:31 INFO - 'ts_paint', 14:58:31 INFO - 'tpaint', 14:58:31 INFO - 'sessionrestore', 14:58:31 INFO - 'sessionrestore_no_auto_restore', 14:58:31 INFO - 'tabpaint']}, 14:58:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['tsvgx', 14:58:31 INFO - 'tsvgr_opacity', 14:58:31 INFO - 'tart', 14:58:31 INFO - 'tscrollx', 14:58:31 INFO - 'cart']}, 14:58:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:58:31 INFO - 'tsvgr_opacity', 14:58:31 INFO - 'tart', 14:58:31 INFO - 'tscrollx', 14:58:31 INFO - 'cart']}, 14:58:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'talos_options': ['--disable-e10s'], 14:58:31 INFO - 'tests': ['tp5o']}, 14:58:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'tests': ['tp5o']}, 14:58:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'talos_options': ['--disable-e10s', 14:58:31 INFO - '--xperf_path', 14:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:31 INFO - 'tests': ['tp5n']}, 14:58:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:58:31 INFO - 'talos_options': ['--xperf_path', 14:58:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:58:31 INFO - 'tests': ['tp5n']}}, 14:58:31 INFO - 'talos.zip': {'path': '', 14:58:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:58:31 INFO - Running post-action listener: _resource_record_post_action 14:58:31 INFO - ##### 14:58:31 INFO - ##### Running create-virtualenv step. 14:58:31 INFO - ##### 14:58:31 INFO - Running pre-action listener: _resource_record_pre_action 14:58:31 INFO - Running main action method: create_virtualenv 14:58:31 INFO - Creating virtualenv /builds/slave/test/build/venv 14:58:31 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 14:58:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:58:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:58:33 INFO - Using real prefix '/usr' 14:58:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:58:33 INFO - Installing distribute.............................................................................................................................................................................................done. 14:58:35 INFO - Installing pip.................done. 14:58:35 INFO - Return code: 0 14:58:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:58:35 INFO - Using env: {'DISPLAY': ':0', 14:58:35 INFO - 'HOME': '/home/cltbld', 14:58:35 INFO - 'LANG': 'en_US.UTF-8', 14:58:35 INFO - 'LANGUAGE': 'en_US:en', 14:58:35 INFO - 'LOGNAME': 'cltbld', 14:58:35 INFO - 'MAIL': '/var/mail/cltbld', 14:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:35 INFO - 'MOZ_NO_REMOTE': '1', 14:58:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:35 INFO - 'NO_EM_RESTART': '1', 14:58:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:35 INFO - 'PWD': '/builds/slave/test', 14:58:35 INFO - 'SHELL': '/bin/bash', 14:58:35 INFO - 'SHLVL': '1', 14:58:35 INFO - 'TERM': 'linux', 14:58:35 INFO - 'TMOUT': '86400', 14:58:35 INFO - 'USER': 'cltbld', 14:58:35 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:35 INFO - '_': '/tools/buildbot/bin/python'} 14:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:36 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 14:58:36 INFO - Cleaning up... 14:58:36 INFO - Return code: 0 14:58:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 14:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 14:58:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 14:58:36 INFO - Using env: {'DISPLAY': ':0', 14:58:36 INFO - 'HOME': '/home/cltbld', 14:58:36 INFO - 'LANG': 'en_US.UTF-8', 14:58:36 INFO - 'LANGUAGE': 'en_US:en', 14:58:36 INFO - 'LOGNAME': 'cltbld', 14:58:36 INFO - 'MAIL': '/var/mail/cltbld', 14:58:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:36 INFO - 'MOZ_NO_REMOTE': '1', 14:58:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:36 INFO - 'NO_EM_RESTART': '1', 14:58:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:36 INFO - 'PWD': '/builds/slave/test', 14:58:36 INFO - 'SHELL': '/bin/bash', 14:58:36 INFO - 'SHLVL': '1', 14:58:36 INFO - 'TERM': 'linux', 14:58:36 INFO - 'TMOUT': '86400', 14:58:36 INFO - 'USER': 'cltbld', 14:58:36 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:36 INFO - '_': '/tools/buildbot/bin/python'} 14:58:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:36 INFO - Downloading/unpacking psutil>=0.7.1 14:58:36 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 14:58:36 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 14:58:36 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 14:58:36 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 14:58:36 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 14:58:36 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 14:58:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:58:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:38 INFO - Installing collected packages: psutil 14:58:38 INFO - Running setup.py install for psutil 14:58:38 INFO - building 'psutil._psutil_linux' extension 14:58:38 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 14:58:40 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 14:58:40 INFO - building 'psutil._psutil_posix' extension 14:58:40 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 14:58:40 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 14:58:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:58:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:58:40 INFO - Successfully installed psutil 14:58:40 INFO - Cleaning up... 14:58:40 INFO - Return code: 0 14:58:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 14:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 14:58:40 INFO - Using env: {'DISPLAY': ':0', 14:58:40 INFO - 'HOME': '/home/cltbld', 14:58:40 INFO - 'LANG': 'en_US.UTF-8', 14:58:40 INFO - 'LANGUAGE': 'en_US:en', 14:58:40 INFO - 'LOGNAME': 'cltbld', 14:58:40 INFO - 'MAIL': '/var/mail/cltbld', 14:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:40 INFO - 'MOZ_NO_REMOTE': '1', 14:58:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:40 INFO - 'NO_EM_RESTART': '1', 14:58:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:40 INFO - 'PWD': '/builds/slave/test', 14:58:40 INFO - 'SHELL': '/bin/bash', 14:58:40 INFO - 'SHLVL': '1', 14:58:40 INFO - 'TERM': 'linux', 14:58:40 INFO - 'TMOUT': '86400', 14:58:40 INFO - 'USER': 'cltbld', 14:58:40 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:40 INFO - '_': '/tools/buildbot/bin/python'} 14:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 14:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 14:58:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:58:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 14:58:42 INFO - Installing collected packages: mozsystemmonitor 14:58:42 INFO - Running setup.py install for mozsystemmonitor 14:58:42 INFO - Successfully installed mozsystemmonitor 14:58:42 INFO - Cleaning up... 14:58:42 INFO - Return code: 0 14:58:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:58:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:58:42 INFO - Using env: {'DISPLAY': ':0', 14:58:42 INFO - 'HOME': '/home/cltbld', 14:58:42 INFO - 'LANG': 'en_US.UTF-8', 14:58:42 INFO - 'LANGUAGE': 'en_US:en', 14:58:42 INFO - 'LOGNAME': 'cltbld', 14:58:42 INFO - 'MAIL': '/var/mail/cltbld', 14:58:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:42 INFO - 'MOZ_NO_REMOTE': '1', 14:58:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:42 INFO - 'NO_EM_RESTART': '1', 14:58:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:42 INFO - 'PWD': '/builds/slave/test', 14:58:42 INFO - 'SHELL': '/bin/bash', 14:58:42 INFO - 'SHLVL': '1', 14:58:42 INFO - 'TERM': 'linux', 14:58:42 INFO - 'TMOUT': '86400', 14:58:42 INFO - 'USER': 'cltbld', 14:58:42 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:42 INFO - '_': '/tools/buildbot/bin/python'} 14:58:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:43 INFO - Downloading/unpacking blobuploader==1.2.4 14:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 14:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:58:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:45 INFO - Downloading docopt-0.6.1.tar.gz 14:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:58:45 INFO - Installing collected packages: blobuploader, requests, docopt 14:58:45 INFO - Running setup.py install for blobuploader 14:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:58:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:58:45 INFO - Running setup.py install for requests 14:58:46 INFO - Running setup.py install for docopt 14:58:46 INFO - Successfully installed blobuploader requests docopt 14:58:46 INFO - Cleaning up... 14:58:46 INFO - Return code: 0 14:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:46 INFO - Using env: {'DISPLAY': ':0', 14:58:46 INFO - 'HOME': '/home/cltbld', 14:58:46 INFO - 'LANG': 'en_US.UTF-8', 14:58:46 INFO - 'LANGUAGE': 'en_US:en', 14:58:46 INFO - 'LOGNAME': 'cltbld', 14:58:46 INFO - 'MAIL': '/var/mail/cltbld', 14:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:46 INFO - 'MOZ_NO_REMOTE': '1', 14:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:46 INFO - 'NO_EM_RESTART': '1', 14:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:46 INFO - 'PWD': '/builds/slave/test', 14:58:46 INFO - 'SHELL': '/bin/bash', 14:58:46 INFO - 'SHLVL': '1', 14:58:46 INFO - 'TERM': 'linux', 14:58:46 INFO - 'TMOUT': '86400', 14:58:46 INFO - 'USER': 'cltbld', 14:58:46 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:46 INFO - '_': '/tools/buildbot/bin/python'} 14:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:46 INFO - Running setup.py (path:/tmp/pip-dla9EV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:46 INFO - Running setup.py (path:/tmp/pip-hGSPo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:46 INFO - Running setup.py (path:/tmp/pip-88pnFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:46 INFO - Running setup.py (path:/tmp/pip-d1UAFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:46 INFO - Running setup.py (path:/tmp/pip-sb0XIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:47 INFO - Running setup.py (path:/tmp/pip-Sx7gj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:47 INFO - Running setup.py (path:/tmp/pip-RTiuys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:47 INFO - Running setup.py (path:/tmp/pip-4AJ9kR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:47 INFO - Running setup.py (path:/tmp/pip-aR4S2h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:47 INFO - Running setup.py (path:/tmp/pip-L_HgQE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:47 INFO - Running setup.py (path:/tmp/pip-zKwQkE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:47 INFO - Running setup.py (path:/tmp/pip-DUYeGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:47 INFO - Running setup.py (path:/tmp/pip-77ZH9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:47 INFO - Running setup.py (path:/tmp/pip-jR9qDH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:47 INFO - Running setup.py (path:/tmp/pip-Uo76Fy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:47 INFO - Running setup.py (path:/tmp/pip-yfSTDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:47 INFO - Running setup.py (path:/tmp/pip-YlF0zY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:58:47 INFO - Running setup.py install for manifestparser 14:58:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:58:47 INFO - Running setup.py install for mozcrash 14:58:48 INFO - Running setup.py install for mozdebug 14:58:48 INFO - Running setup.py install for mozdevice 14:58:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for mozfile 14:58:48 INFO - Running setup.py install for mozhttpd 14:58:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for mozinfo 14:58:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for mozInstall 14:58:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for mozleak 14:58:48 INFO - Running setup.py install for mozlog 14:58:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for moznetwork 14:58:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:58:48 INFO - Running setup.py install for mozprocess 14:58:49 INFO - Running setup.py install for mozprofile 14:58:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:58:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:58:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:58:49 INFO - Running setup.py install for mozrunner 14:58:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:58:49 INFO - Running setup.py install for mozscreenshot 14:58:49 INFO - Running setup.py install for moztest 14:58:49 INFO - Running setup.py install for mozversion 14:58:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:58:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:58:49 INFO - Cleaning up... 14:58:49 INFO - Return code: 0 14:58:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:58:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:49 INFO - Using env: {'DISPLAY': ':0', 14:58:49 INFO - 'HOME': '/home/cltbld', 14:58:49 INFO - 'LANG': 'en_US.UTF-8', 14:58:49 INFO - 'LANGUAGE': 'en_US:en', 14:58:49 INFO - 'LOGNAME': 'cltbld', 14:58:49 INFO - 'MAIL': '/var/mail/cltbld', 14:58:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:49 INFO - 'MOZ_NO_REMOTE': '1', 14:58:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:49 INFO - 'NO_EM_RESTART': '1', 14:58:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:49 INFO - 'PWD': '/builds/slave/test', 14:58:49 INFO - 'SHELL': '/bin/bash', 14:58:49 INFO - 'SHLVL': '1', 14:58:49 INFO - 'TERM': 'linux', 14:58:49 INFO - 'TMOUT': '86400', 14:58:49 INFO - 'USER': 'cltbld', 14:58:49 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:49 INFO - '_': '/tools/buildbot/bin/python'} 14:58:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:58:49 INFO - Running setup.py (path:/tmp/pip-MAFU8S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:58:49 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:58:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:58:49 INFO - Running setup.py (path:/tmp/pip-r2OWUM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:58:50 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)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:58:50 INFO - Running setup.py (path:/tmp/pip-KKOvHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:58:50 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)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:58:50 INFO - Running setup.py (path:/tmp/pip-WI3dXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:58:50 INFO - Running setup.py (path:/tmp/pip-lDp_zI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:58:50 INFO - Running setup.py (path:/tmp/pip-vcNlZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:58:50 INFO - Running setup.py (path:/tmp/pip-03mEAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:58:50 INFO - Running setup.py (path:/tmp/pip-O_Luww-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:58:50 INFO - Running setup.py (path:/tmp/pip-e3E2sa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:58:50 INFO - Running setup.py (path:/tmp/pip-sQMm5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:58:50 INFO - Running setup.py (path:/tmp/pip-GihxrF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:58:50 INFO - Running setup.py (path:/tmp/pip-1fmaY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:58:50 INFO - Running setup.py (path:/tmp/pip-6O50GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:58:50 INFO - Running setup.py (path:/tmp/pip-Gp8P_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:50 INFO - Running setup.py (path:/tmp/pip-D5MZWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:58:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:58:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:58:50 INFO - Running setup.py (path:/tmp/pip-LmQVKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:58:51 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)) 14:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:58:51 INFO - Running setup.py (path:/tmp/pip-E9K8B8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:58:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:58:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:58:52 INFO - Downloading blessings-1.6.tar.gz 14:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:58:53 INFO - Installing collected packages: blessings 14:58:53 INFO - Running setup.py install for blessings 14:58:53 INFO - Successfully installed blessings 14:58:53 INFO - Cleaning up... 14:58:53 INFO - Return code: 0 14:58:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:58:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:53 INFO - Reading from file tmpfile_stdout 14:58:53 INFO - Current package versions: 14:58:53 INFO - argparse == 1.2.1 14:58:53 INFO - blessings == 1.6 14:58:53 INFO - blobuploader == 1.2.4 14:58:53 INFO - docopt == 0.6.1 14:58:53 INFO - manifestparser == 1.1 14:58:53 INFO - mozInstall == 1.12 14:58:53 INFO - mozcrash == 0.17 14:58:53 INFO - mozdebug == 0.1 14:58:53 INFO - mozdevice == 0.48 14:58:53 INFO - mozfile == 1.2 14:58:53 INFO - mozhttpd == 0.7 14:58:53 INFO - mozinfo == 0.9 14:58:53 INFO - mozleak == 0.1 14:58:53 INFO - mozlog == 3.1 14:58:53 INFO - moznetwork == 0.27 14:58:53 INFO - mozprocess == 0.22 14:58:53 INFO - mozprofile == 0.28 14:58:53 INFO - mozrunner == 6.11 14:58:53 INFO - mozscreenshot == 0.1 14:58:53 INFO - mozsystemmonitor == 0.0 14:58:53 INFO - moztest == 0.7 14:58:53 INFO - mozversion == 1.4 14:58:53 INFO - psutil == 3.1.1 14:58:53 INFO - requests == 1.2.3 14:58:53 INFO - wsgiref == 0.1.2 14:58:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:58:53 INFO - Using env: {'DISPLAY': ':0', 14:58:53 INFO - 'HOME': '/home/cltbld', 14:58:53 INFO - 'LANG': 'en_US.UTF-8', 14:58:53 INFO - 'LANGUAGE': 'en_US:en', 14:58:53 INFO - 'LOGNAME': 'cltbld', 14:58:53 INFO - 'MAIL': '/var/mail/cltbld', 14:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:53 INFO - 'MOZ_NO_REMOTE': '1', 14:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:53 INFO - 'NO_EM_RESTART': '1', 14:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:53 INFO - 'PWD': '/builds/slave/test', 14:58:53 INFO - 'SHELL': '/bin/bash', 14:58:53 INFO - 'SHLVL': '1', 14:58:53 INFO - 'TERM': 'linux', 14:58:53 INFO - 'TMOUT': '86400', 14:58:53 INFO - 'USER': 'cltbld', 14:58:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:53 INFO - '_': '/tools/buildbot/bin/python'} 14:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:58:53 INFO - Cleaning up... 14:58:53 INFO - Return code: 0 14:58:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:58:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:58:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:58:53 INFO - Using env: {'DISPLAY': ':0', 14:58:53 INFO - 'HOME': '/home/cltbld', 14:58:53 INFO - 'LANG': 'en_US.UTF-8', 14:58:53 INFO - 'LANGUAGE': 'en_US:en', 14:58:53 INFO - 'LOGNAME': 'cltbld', 14:58:53 INFO - 'MAIL': '/var/mail/cltbld', 14:58:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:53 INFO - 'MOZ_NO_REMOTE': '1', 14:58:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:53 INFO - 'NO_EM_RESTART': '1', 14:58:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:53 INFO - 'PWD': '/builds/slave/test', 14:58:53 INFO - 'SHELL': '/bin/bash', 14:58:53 INFO - 'SHLVL': '1', 14:58:53 INFO - 'TERM': 'linux', 14:58:53 INFO - 'TMOUT': '86400', 14:58:53 INFO - 'USER': 'cltbld', 14:58:53 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:53 INFO - '_': '/tools/buildbot/bin/python'} 14:58:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:53 INFO - Downloading/unpacking jsonschema 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:53 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 14:58:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:58:55 INFO - Downloading/unpacking functools32 (from jsonschema) 14:58:55 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 14:58:55 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 14:58:55 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 14:58:55 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 14:58:55 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 14:58:55 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 14:58:56 INFO - Downloading functools32-3.2.3-2.tar.gz 14:58:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:58:56 INFO - warning: no files found matching '*.txt' 14:58:56 INFO - no previously-included directories found matching 'build' 14:58:56 INFO - no previously-included directories found matching 'dist' 14:58:56 INFO - no previously-included directories found matching '.git*' 14:58:56 INFO - Installing collected packages: jsonschema, functools32 14:58:56 INFO - Running setup.py install for functools32 14:58:56 INFO - warning: no files found matching '*.txt' 14:58:56 INFO - no previously-included directories found matching 'build' 14:58:56 INFO - no previously-included directories found matching 'dist' 14:58:56 INFO - no previously-included directories found matching '.git*' 14:58:56 INFO - Successfully installed jsonschema functools32 14:58:56 INFO - Cleaning up... 14:58:56 INFO - Return code: 0 14:58:56 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:58: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')]} 14:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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')]} 14:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:58: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd42aa09f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ae58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bb05a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, '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-1461188973.122163-1519280798', '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 14:58: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', 'flake8'] in /builds/slave/test/build 14:58: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 flake8 14:58:56 INFO - Using env: {'DISPLAY': ':0', 14:58:56 INFO - 'HOME': '/home/cltbld', 14:58:56 INFO - 'LANG': 'en_US.UTF-8', 14:58:56 INFO - 'LANGUAGE': 'en_US:en', 14:58:56 INFO - 'LOGNAME': 'cltbld', 14:58:56 INFO - 'MAIL': '/var/mail/cltbld', 14:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:58:56 INFO - 'MOZ_NO_REMOTE': '1', 14:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:58:56 INFO - 'NO_EM_RESTART': '1', 14:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:58:56 INFO - 'PWD': '/builds/slave/test', 14:58:56 INFO - 'SHELL': '/bin/bash', 14:58:56 INFO - 'SHLVL': '1', 14:58:56 INFO - 'TERM': 'linux', 14:58:56 INFO - 'TMOUT': '86400', 14:58:56 INFO - 'USER': 'cltbld', 14:58:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:58:56 INFO - '_': '/tools/buildbot/bin/python'} 14:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:58:56 INFO - Downloading/unpacking flake8 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58: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 14:58:58 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:58:58 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:58:58 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:58 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 14:58:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:58:59 INFO - no previously-included directories found matching 'docs/_build' 14:58:59 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:58:59 INFO - Running setup.py install for pep8 14:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:58:59 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:58:59 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:58:59 INFO - no previously-included directories found matching 'docs/_build' 14:58:59 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:58:59 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:58:59 INFO - Cleaning up... 14:58:59 INFO - Return code: 0 14:58:59 INFO - Running post-action listener: _resource_record_post_action 14:58:59 INFO - Running post-action listener: _start_resource_monitoring 14:58:59 INFO - Starting resource monitoring. 14:58:59 INFO - ##### 14:58:59 INFO - ##### Running install step. 14:58:59 INFO - ##### 14:58:59 INFO - Running pre-action listener: _resource_record_pre_action 14:58:59 INFO - Running main action method: install 14:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:58:59 INFO - Reading from file tmpfile_stdout 14:58:59 INFO - Detecting whether we're running mozinstall >=1.0... 14:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:58:59 INFO - Reading from file tmpfile_stdout 14:58:59 INFO - Output received: 14:58:59 INFO - Usage: mozinstall [options] installer 14:58:59 INFO - Options: 14:58:59 INFO - -h, --help show this help message and exit 14:58:59 INFO - -d DEST, --destination=DEST 14:58:59 INFO - Directory to install application into. [default: 14:58:59 INFO - "/builds/slave/test"] 14:58:59 INFO - --app=APP Application being installed. [default: firefox] 14:58:59 INFO - mkdir: /builds/slave/test/build/application 14:58:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:58:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:59:15 INFO - Reading from file tmpfile_stdout 14:59:15 INFO - Output received: 14:59:15 INFO - /builds/slave/test/build/application/firefox/firefox 14:59:15 INFO - Running post-action listener: _resource_record_post_action 14:59:15 INFO - ##### 14:59:15 INFO - ##### Running run-tests step. 14:59:15 INFO - ##### 14:59:15 INFO - Running pre-action listener: _resource_record_pre_action 14:59:15 INFO - Running main action method: run_tests 14:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:59:15 INFO - Python 2.7.3 14:59:15 INFO - Return code: 0 14:59:15 INFO - grabbing minidump binary from tooltool 14:59: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')]} 14:59:15 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c3f410>, '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 0x1c40310>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1c407a0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:59:15 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 14:59:15 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 14:59:15 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:59:15 INFO - Return code: 0 14:59:15 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:59:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:59:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:59:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:59:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:59:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:59:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:59:16 INFO - Return code: 0 14:59:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.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 14:59:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.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 14:59:16 INFO - Using env: {'DISPLAY': ':0', 14:59:16 INFO - 'HOME': '/home/cltbld', 14:59:16 INFO - 'LANG': 'en_US.UTF-8', 14:59:16 INFO - 'LANGUAGE': 'en_US:en', 14:59:16 INFO - 'LOGNAME': 'cltbld', 14:59:16 INFO - 'MAIL': '/var/mail/cltbld', 14:59:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:59:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:59:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:59:16 INFO - 'MOZ_NO_REMOTE': '1', 14:59:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:59:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:59:16 INFO - 'NO_EM_RESTART': '1', 14:59:16 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:59:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:59:16 INFO - 'PWD': '/builds/slave/test', 14:59:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:59:16 INFO - 'SHELL': '/bin/bash', 14:59:16 INFO - 'SHLVL': '1', 14:59:16 INFO - 'TERM': 'linux', 14:59:16 INFO - 'TMOUT': '86400', 14:59:16 INFO - 'USER': 'cltbld', 14:59:16 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1461188973.122163-1519280798', 14:59:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:59:16 INFO - '_': '/tools/buildbot/bin/python'} 14:59:16 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.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 14:59:16 INFO - mozversion application_buildid: 20160420135553 14:59:16 INFO - mozversion application_changeset: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 14:59:16 INFO - mozversion application_display_name: Nightly 14:59:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:59:16 INFO - mozversion application_name: Firefox 14:59:16 INFO - mozversion application_remotingname: firefox 14:59:16 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:59:16 INFO - mozversion application_vendor: Mozilla 14:59:16 INFO - mozversion application_version: 48.0a1 14:59:16 INFO - mozversion platform_buildid: 20160420135553 14:59:16 INFO - mozversion platform_changeset: 93090fa3065335c9f830e9c70cbfbbc2f40fd979 14:59:16 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:59:16 INFO - mozversion platform_version: 48.0a1 14:59:16 INFO - using testdate: 1461189556 14:59:16 INFO - actual date: 1461189556 14:59:16 INFO - starting webserver on 'localhost:43664' 14:59:16 INFO - SUITE-START | Running 2 tests 14:59:16 INFO - TEST-START | dromaeo_css 14:59:16 INFO - operating with platform_type : linux_ 14:59:16 INFO - Initialising browser for dromaeo_css test... 14:59:16 INFO - TEST-INFO | started process 3284 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zQiMV/profile http://localhost:43664/getInfo.html) 14:59:21 INFO - PROCESS | 3284 | __metrics Screen width/height:1600/1200 14:59:21 INFO - PROCESS | 3284 | colorDepth:24 14:59:21 INFO - PROCESS | 3284 | Browser inner width/height: 1024/697 14:59:21 INFO - PROCESS | 3284 | __metrics 14:59:22 ERROR - PROCESS | 3284 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 14:59:23 INFO - TEST-INFO | 3284: exit 0 14:59:23 INFO - Browser initialized. 14:59:23 INFO - Running cycle 1/1 for dromaeo_css test... 14:59:23 INFO - TEST-INFO | started process 3369 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp8zQiMV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:59:35 INFO - PROCESS | 3369 | RSS: Main: 155049984 14:59:35 INFO - PROCESS | 3369 | 15:00:26 INFO - PROCESS | 3369 | 1461189626770 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] 15:02:37 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43664/tests/dromaeo/cssquery-ext.html) 15:02:39 INFO - PROCESS | 3369 | RSS: Main: 266240000 15:02:39 INFO - PROCESS | 3369 | 15:05:41 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-ext.html (next: http://localhost:43664/tests/dromaeo/cssquery-jquery.html) 15:05:42 INFO - PROCESS | 3369 | RSS: Main: 234991616 15:05:42 INFO - PROCESS | 3369 | 15:08:44 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43664/tests/dromaeo/cssquery-mootools.html) 15:08:45 INFO - PROCESS | 3369 | RSS: Main: 231129088 15:08:45 INFO - PROCESS | 3369 | 15:11:47 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43664/tests/dromaeo/cssquery-prototype.html) 15:11:47 INFO - PROCESS | 3369 | RSS: Main: 238624768 15:11:47 INFO - PROCESS | 3369 | 15:14:50 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43664/tests/dromaeo/cssquery-yui.html) 15:14:51 INFO - PROCESS | 3369 | RSS: Main: 214458368 15:14:51 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | Cycle 1(1): loaded http://localhost:43664/tests/dromaeo/cssquery-yui.html (next: http://localhost:43664/tests/dromaeo/cssquery-dojo.html) 15:17:54 INFO - PROCESS | 3369 | RSS: Main: 271261696 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | __start_tp_report 15:17:54 INFO - PROCESS | 3369 | _x_x_mozilla_page_load 15:17:54 INFO - PROCESS | 3369 | _x_x_mozilla_page_load_details 15:17:54 INFO - PROCESS | 3369 | |i|pagename|runs| 15:17:54 INFO - PROCESS | 3369 | |0;dojo.html;2566.1531694540804;2620.908268210614;2629.6187052877344;2638.8944442222314;2659.4681063787243;4453.576910193527;4529.796159172837;4532.501424843269;4543.182227199103;4551.2717965125585;4616;4648.860534183971;4671.392718946532;4693.037927224919;4697.17799385108;4185.016521117543;4186.204621121992;4206.537280899099;4239.745615263078;4385.583369579885;4261.147770445908;4340.9565904341025;4342.305231162999;4355.150745604608;4386.517483076859;4116.855910043164;4157.210130075276;4200.684948628865;4234.534201237861;4273.273543497582;4234.195502854479;4242.2576049191575;4243.745375277463;4247.617714405718;4287.849925252601;4227.471566054243;4236.173946080516;4241.766702831343;4267.167902259061;4275.615194632498;4398.3842262083335;4551.317302404633;4585.28928016158;4624.028953919681;4636.675432719711;4846.830360937385;4877.317175595419;4880.707157570557;4881.414230292387;4900.31395604612;4801.063792560452;4900.044491324194;4904.754762261872;4916.975415122902;4958.702477851304;4570.977145114286;4609.354690343354;4610.677252592353;4650.976745116287;4656.767161641972;4920.384951881015;4947.579455746302;4948.035133149074;4964.429090654548;4997.675151115166;4755.785989630475;4759.405074365704;4760.309755085494;4770.856874293777;4850.1269771441475;4989;4991.176455884811;5024.84428581421;5046.470120637354;5058.671186372874;4934.136526107916;4939.703617782944;4948.752562371867;4958.528939750718;5017.8243761468175;4740.834070807505;4913.336699545515;4938.728369939688;4944.9258261126115;4993.850184494471;4100.630943215125;4144.44050053245;4215.072684009513;4218.346156345771;4219.282721937278;3616.674499295076;3630.546181727284;3634.4548317752547;3664.193877346979;3666.431703086026;4208.368744688321;4215;4226.260404429274;4226.978865105655;4262.6376757975295;4767.904641907212;4927.137750893579;4963.106640804617;4997.625178111656;5007.974960125176;4200.537940826506;4218.915621687549;4221.155768846243;4222.345536441856;4250.468691413574;4423.336499525097;4424.889377765518;4429.446319210098;4450.666200035011;4475.462944446622;4560.612347950395;4694.64790140734;4734.715917044989;4767.475577686382;4782.0914026334885;4914.189158788759;4927.359443272351;4934;4940.75296235194;4996.575291100297;4436.334549817553;4684.110019096361;4688.765561721969;4693.131770622445;4742.881427964328;4780.904381912273;4806.303086052572;4824.782884770124;4831.106245344622;4850.102730994778;4835.95164048369;4847.200211964986;4863.878403039952;4867;4933.901321973469;4695.201815691409;4710.528947105262;4736.313234580897;4751.714897106184;4757.643176761688;4707.317438971399;4720.339152518582;4726.409198850144;4761.452432970253;4767.642426818072;4648.953510464988;4690.695104818176;4696.2486002239475;4709.152352576569;4737.360456338351;4663.836765713184;4768.356271903249;4799.088173247072;4808.735519546459;4850.563449289581;4698.060387922497;4716.716996980193;4716.905661886674;4757.14371413149;4766.571008609242 15:17:54 INFO - PROCESS | 3369 | |1;ext.html;552.770100415272;566.4363957861926;590.5334785519441;592.8399332180309;607.6840043177546;26609.334766630844;27163.320916977085;27234.86382568087;27236.45527089457;27242.45515089697;33979.83010084946;34284;35175.64824351756;35203.471947920734;35243.82378088106;7597;7812.609369531529;7815.25755053269;7816.140224575321;7821.491603045813;7255.09311336083;7638.159802421729;7804.453688241825;9700.805983880318;10056.849147262797;9650.855237171449;9748.610055597768;9751.463669498211;9758.268129890252;9768.169705575036;9679.661211857587;9764.414135151914;9797.510124493818;9797.853032204523;9800.411975281506;9564.713058608253;9723.708288751348;9732.026797320212;9732.70801875945;9736.318457707963;37149.814250928575;37735.35852490327;37808.243835123416;37808.43287350692;37854;3079.1532328609587;3082.04456618449;3218.5333126696496;3219.4526930421885;3266.199781053633;28416.94832329023;28490.430191396055;28593.285167870763;28868.73584548019;29388;3318.1206980150278;3349.246419555605;3354.3459025490038;3377.4764911438765;3380.9830950845335;244675;245189;245320;245701;246386.76806616032;50694.74652626713;51213.231801523005;51358.22962655563;51393;51413.7429312851;54678.45321546813;54935.72532137394;55296.447035529935;55357.72321138449;55378;13281.335933203301;13535.526256580972;13541.322933853267;13543.661408464866;13544.932275338757;10619.681409557727;10721.249512534048;10795.136389088853;10803.783924321628;10820.02619764225;14782.556523304318;15161.241937903282;15168.620784480256;15284.312205950759;15447.845521544641;5559.360673522516;5820.476157145792;5865.589408741347;5910.645361278337;5992.970035149797;879.1208791208791;894.8389289927745;929.8884133903839;969.0019280141465;994.786120983992;27141.457170856473;27944.580831287545;28039.579406308923;28339.858300708365;28593.14220573386;825.3933358981144;962.6919385796477;973.2262851033446;985.1626117799813;1008.369768894441;13309.467621295233;13654.726905461835;13891.722165556632;13911.721765564835;13934.651633709036;339639;342180;342657;343713;346040;47478.5252147481;47965.280520792214;48037.519624804;48089.27866082011;48209.758951205724;1104.216006635282;1163.953441862316;1252.3612957391795;1270.6950331920457;1279.654493286826;24518.877405612857;25721.871390642926;27401.314967125185;27752.14139973003;28015.719842802126;36982.63017369792;37578.812105939294;37609;37672.246555069294;37684;225569;230777;230797;231276;518558;34692.30615387729;35535.28929421449;36026.63973360233;36178.20128886534;36466.63533364632;35679.28641427105;35908.64091359053;36272;36575.817120914224;36825.63174368222;32024.199395015312;33773.3245335087;33999.66000340064;34706.652933470345;34863;33101.834490827394;33717.83141084279;33727.15682107967;34006.3198736019;34140.658593414744;34083.14792130217;34409.311813764085;34649.30701386009;34873.82563087168;34910.476342855385;29416.55875161917;30556.236094097825;30692.693073069877;30863.524788905033;30917;24485.14301999493;24487;24525.38686532851;24902.750972490045;24923 15:17:54 INFO - PROCESS | 3369 | |2;jquery.html;369.4458312531204;373.674902834534;376.1930658737009;379.7190079341287;383.37127111537103;16193.218745937953;16394.26225819838;16590.83409165908;16617.83382166178;16631.41790037349;14691.92654036731;15988.84011159888;16099.19504024797;16123.516294511184;16165.757513637305;4892.3639926809465;5030.019146266462;5065.974670126662;5089.211172268304;5092.083424983502;3599.226166374229;3745.45690874823;3749.9250014999684;3752.08074021865;5035.823746168885;3832.156925476391;5683.573731970118;5692.430756924316;5697.74360153792;5714;5564.777408903639;5695.601307908448;5766.365699773021;5771.451712087345;5786;4875.951240487585;5089.41471730752;5129.461406552296;5135.35808023997;5138.691678499302;20471.48821279465;20602.690959635616;20721.159097905682;20781.376558703265;21178.152873885025;1836.3113832312883;1914.3108480946848;2021.9696704549444;2094.0158125680905;2540.7840333571667;5950.553708471882;5994.550408719363;10816.891831081668;12519.311437870914;12720.681982950407;1771.7785276840395;1786.4640607817732;1839.4941391117416;1857.201403396539;1864.0679660169915;66859;67207.32792672109;67283.66358168177;67317;67991;9135.680251191176;9409.764755881159;9424.717258482257;9546.18857397115;9675.129238368581;13076.607701768962;13151.342432878319;13162.407691653898;13169.73660526784;13190.559746446746;6531.673416329165;6727.730890764413;6773.695183716744;6813.965930170318;6825.590464572141;6405.583637063669;6439.581427207217;6447.484201263887;6533.673316334164;6556.147700798961;6024.186734790747;6036.215292012011;6071.726772295257;6091.284316566891;6107.816765497042;1701.2939630053636;1748.9650206995789;1757.7099778536654;1767.169430367725;1771.663383957044;861.1517655109712;866.4714524140269;917.2111983694018;964.2864280432569;1024.4365598920565;16444.506664800076;17186.74219886703;17258.050807205473;17293.740593891103;17610.64778704419;871.285545852395;892.9953801972781;901.121406628532;911.2300106410073;944.2493217891792;9572.138507534355;9877.357971731815;10088.394696318244;10105.898941010495;10249.436281004617;386883;395684;405593;407038;408554;65430;67925.66037169783;68844.31155688479;69633;72037.6398118006;956.9234461243084;962.2975228083399;970.9514524273758;993.9503024848729;994.5126887824914;14831.184284864004;14890.553283401516;15248.237588120328;15969.361225550847;16145.596360090622;34658;35008;35343.29313413769;35510.82244588761;35521.64478355287;43581.78209109061;44511;45552.54447455483;50086.24870626871;50177;7474.925250747423;7686.3082322591235;7740.064983754061;7959;8011.719589814562;10767.192460565333;10982.450877455936;11364.693060298172;11432.428378580871;11528.884711152781;10102.292839501164;10272.589096436059;10384.221183411426;10500.159987200852;10509.842352364874;9462.858057129011;10104.141148002502;10307.433091180057;10403.323783954018;10635.042846143884;10373.222008349254;10664.946675266574;10799.784004320027;10860.565577376816;10911;7752.604531184441;7906.288434040964;7993.1607181247455;8172.019357676879;8234.382421318305;9585.233181345337;10159.288849780445;10383.688489345332;10453.529591168264;10937.945310273397 15:17:54 INFO - PROCESS | 3369 | |3;mootools.html;1239.727260002799;1368.890488760899;1443.1846007006043;1531.471642283412;1733.393312340681;6723.529352945296;7425.777226683194;7655.08139023318;7680.3087722105;7689.846203075942;7421.703131874719;7581.052368453943;7592.658330375132;7593.468457207998;7603.087629484469;1917.453525745163;2194.692743015979;2207.3598656389668;2209.591225623265;2259.401258666455;2267.1724820440586;2285.108807565051;2287.656851472284;2288.8855557222155;2289.095807156172;2213.7232845894264;2235.2065016919005;2247.9662805057856;2256.277991042859;2258.6837842702034;1906.5996140810446;2171.4028642123308;2236.4856083100976;2237.9216727414623;2239.5185035217505;2132.4988627672483;2138.101997161196;2145.410012246629;2146.9141234350764;2196.879171645559;7525.096988361377;7529.360004399633;7529.5482271063365;7585.696572137108;7593.696252149907;4342.435483387139;4474.977625111854;4482.843100491467;4491.191585514606;4541.45502539694;2902.9854850725824;2961.496545587234;2973.405318936221;2984.2091845660916;3033.3326668132977;939.6429356844424;942.3686130292721;976.0581039297041;982.3172894838091;992.161623428202;10271.743206419824;10283.794324113476;10283.948580257125;10290.485475726184;10297.02178293061;4127.360259159835;4162.229987452331;4258.382534532538;4385.912281754347;4389.84635537761;8819.647214111365;8830.116988301246;8832.425892316978;8847.46915185091;8872.73381798547;4055.6755459563165;4600.21796294624;4627.213373726475;4635.235186194308;4649.418822647169;4062.4921884764403;4114.794260286973;4123.9381409278885;4127.33962565994;4158.147579746144;3619.2942376236906;3630.546181727284;3719.274741425396;3741.270452261783;3761.5110035695184;1193.2184419205435;1198.6164427383328;1214.6963259185204;1224.589762429596;1235.43170141734;786.5595266650694;869.9956500217459;902.2826852652157;903.6475774447971;912.7124955638952;5395.595330350239;5438.619296649196;5525.834224973257;5600.747966341524;5634.352049514277;835.2482765511089;863.4560227056913;874.6807415293372;906.7551761024487;943.8442656961524;3645.453182022665;3803.5625903020955;3828.980855095707;3855.575886652466;3900.863469778601;8629.137086291446;8976.551172441352;9023.323250756219;9055.864162037575;9390.389624674512;9136.451812891248;9146.399380108454;9221.677241296522;9253.583588738524;9268.841394825648;6962.408195303355;7028.0863487746265;7032.789016329519;7110.537815042006;7247.275272472816;5545.528630066328;5586.329640443173;5593.580481463825;5640.633358831663;5743.282089738783;8599.785005374915;8733.868991964999;8742.56287185651;8748.956255218684;8764;8536.317094632539;8851.114888511098;8880.644774208959;8947.463152210888;8972.057933917105;6031.909521357095;6222.128901953821;6228.501719862491;6722.630255335808;6847.349501797321;6661.700223489857;7140.9285907140265;7416.961625372344;7417.666205020679;7426.888596671162;6755.864882702417;6933.375996160168;6965.965170174117;7162.677679504331;7240.239774823778;6867.141607299088;6882.5870447773295;6932.688029038806;6986.336298051677;7007.369336759716;6147.477464415575;6158.876822463615;6193.876122477615;6261.217347831521;6340.397662222082;4728;4785.186518291968;4865.537773911473;4898.53463920927;4909.828156014522;4899.16714158601;4931.211006238985;4933.358663373739;4957.851264462072;5000.699958002531 15:17:54 INFO - PROCESS | 3369 | |4;prototype.html;308.14028859482045;309.302522811061;311.56847765844316;315.3283506131939;315.5424634280294;4972.179590367594;4996.825111121116;5003.574696150827;5007.699538027712;5011.69929804212;4979.551840334369;4984.551390374865;4989.351384320043;5006.774695138718;5015.9749201254035;3738.4392341148773;3832.310184166849;3849.2878817418728;3948.763074215542;3996.7402118862183;3926.27363937671;3966.7619942803526;3973.1656352165937;3988.142549351903;3996.3605823068315;3688.6311368863035;3925.234579257046;3944.1322908959983;3944.644981951624;3959.524857017162;3756.6806821420214;3884.553276373225;3891.105045839473;3896.8246428910625;3914.373700207953;3437.295354452331;3437.8281085945605;3451.3097380523996;3454.913627159316;3484.8431820568135;4798.976005119952;4799.3760811094335;4800.567948884583;4824.879378015543;4827.951720482785;4348.804303806336;4489.595936365743;4495.943453288474;4507.684462087655;4510.774461276923;5223.921641175385;5225.843224703265;5230.21546767984;5242.7378631068295;5242.973785131088;3769.9821048317076;3783.0920579061103;3789.8484060637543;3790;3809.561900381464;5290.814821481268;5424.321959755031;5456.727163641802;5460.726963651841;5513.3108361454815;3836.76979381238;3884.0678237222864;3885.514310711161;3888.5528164260904;3893.824777885002;3933.449317095609;3941.704372172041;3948.940765888514;3962.3858301962664;3973.642372186517;4355.782210889506;4451.399061126771;4469.687121901436;4471.837322296162;4473.619742321939;5224.111900976843;5243.947560524422;5255.842324730264;5257.658252213594;5266.552343050884;1357.4841560207058;1377.5247539598822;1379.2276325257687;1379.6343968848264;1380.6686395265065;879.0769691823559;919.7424721078108;940.9388389754781;941.924646028316;965.7971825916495;4561.794719237642;4569.268916973335;4570.702904311209;4570.9314360284625;4573.63410927125;5346.385165705916;5346.652467589594;5346.705931173745;5352.090144675414;5355.651882627617;4377.343398490252;4552.97723511387;4561.361409402686;4566.383538222364;4570.337301091389;2846.672632647231;2850.1307101333878;2865.9713402865705;2870.196345023355;2882.106546970446;5067.594592432597;5081.466446023188;5088.160453525201;5090.236464530276;5092.236164575269;5268.92096618551;5498.147787093007;5500.779968801203;5629.887402251932;5655.123455864347;5195.740212989411;5213.947860521498;5222.477752224747;5230.110881150214;5232.372115346183;5455.8363249102595;5462.945370546244;5477.890442191054;5490;5503.504684578407;5221.947780522298;5373.865653358697;5395.81114660985;5408.648437851684;5408.891822163613;5196.68819870809;5197.997541892646;5198.090334191425;5204.200933318622;5222.42553319127;3781.905452363713;3811.2377524495764;3816.37029890065;3819.446180303785;3824.521934758155;5371.462853714597;5461.262729531462;5478.753456094406;5492.862678433071;5497.697626630574;5279.419263880894;5306.8938621228135;5318.8936221276135;5321;5329.7068661224;5090.618203634816;5229.764660590206;5310.3893052297935;5312.7343632818975;5315.388730295911;4971.81240254287;5191.351081114861;5199.610029247746;5216.087184742579;5217.295665085317;5130.923036154535;5305.806193606562;5333.43998880112;5361.35663720356;5368.597355198453;5187.403448603459;5199.948000520098;5215.29593504872;5215.5827533797965;5225.268462415341 15:17:54 INFO - PROCESS | 3369 | |5;yui.html;691.4537515362864;779.6438467726718;794.9125596184418;802.193795235788;804.0150815251314;12250.877491225085;12563.120581559271;12583.811242831365;12586.937065314673;12620.179688320264;12031.398430078483;12091.516339346437;12147.271163730182;12152.939235303833;12171.695707607314;623.9594426362295;794.749653859034;806.7136166660839;807.3379828540599;808.0989696488432;762.1387831750114;789.0925435748906;793.4763056382789;793.5040599625235;793.8253584211465;826.1449399871104;833.017039892926;835.1398059998212;835.1690068381969;835.9373047021468;658.1148355461896;819.5451524403953;828.9419740618159;829.3489610655637;830.7466222802074;621.7046902721171;622.9065640153968;623.5043140703152;623.9126522286883;623.9500839932795;12207.389630518439;12212.206206596631;12214.57248996281;12223.388830558437;12238.632841014783;12392.31842248676;12924.224546527239;12945.352732363439;13179.55024947255;13378.264195469244;10332.535035923327;10343.482825858751;10412.219083568763;10518.526666300035;10546.36721796687;3218.1793642620983;3289.9342013159603;3323.21904352477;3417.248205394834;3477.7739446935866;42739.14521709579;43022.56977430217;43622.781886090364;43703.34444983296;43814.78092609548;9578.425294482353;9956.850647240297;10016.248781341283;10234.232432567587;10254.384736915808;17286.567835803955;17376.913115434596;17604.647907041788;17645.38241161579;17646.294148233927;6914.997325387791;6977.33715297046;7098.3256590623805;7118.28817118284;7145.178304494945;3664.76179048361;3723.6090210528046;3729.2355067211156;3801.4867992820614;3946.4474973503734;2928.7217714317107;2984.134600965739;2984.358362951976;2987.3726517431583;2988.9850550747105;496.3993567783023;519.1071357265497;530.1544037260563;532.1538753382141;532.48615086441;521.5045706578766;581.1776336483828;632.8892443822313;647.5167731748702;681.5910453727723;7832.334251588565;8106.310963568163;8203.261706446448;8323.916760832435;8394.118617545191;527.860117068977;594.6848170469658;625.6558892609047;640.7533099756628;657.0505619380045;3974.364101743707;3988.2861525589087;3997.1006523532556;4029.778362190049;4084.6936479764136;51411.742941285804;51833;52343;52456.21315680268;52823.47176528262;44799;45558.772206138754;45805.7709711456;45898.311525327146;46354;39639.80180099081;39965.60034399677;40757;41825.581744183386;41841.79079104585;7764.495307804975;7868.685252589832;7933.801654958672;7945.245201705829;7987.440879138405;28370.148895533166;28435;28584.142475725763;28884.566731499464;29356.559651604817;34103.147421313675;34281.657183427844;37076.81461592675;37322.253554929295;38370.80814596021;9248.075192480697;9263.342745677042;9444.433333999981;9464.621415143318;9492.715218543455;10585.176196725939;10670.89329106699;10769.40768257722;10783.460826958777;10837.349759014169;9897.50512474359;10132.848007279748;10229.948850255998;10334.379937203792;10552.103071239031;8569.65721371163;8641.913580864111;8727.127287271222;8815.294776417742;9120.087991201091;9466.905330946602;9669.129778319984;9672.77526168971;9920;9957.651482198089;8295.294899933331;8615.569221538773;8700.390972631854;8743.737687869374;8771.298296136167;8569.228769410784;8571.614277357408;8609.870851937101;8659.437136586102;8718.782030449289 15:17:54 INFO - PROCESS | 3369 | __end_tp_report 15:17:54 INFO - PROCESS | 3369 | __start_cc_report 15:17:54 INFO - PROCESS | 3369 | _x_x_mozilla_cycle_collect,1063 15:17:54 INFO - PROCESS | 3369 | __end_cc_report 15:17:54 INFO - PROCESS | 3369 | __startTimestamp1461190674266__endTimestamp 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | ------- Summary: start ------- 15:17:54 INFO - PROCESS | 3369 | Number of tests: 6 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#0] dojo.html Cycles:165 Average:4544.47 Median:4694.65 stddev:464.63 (9.9%) stddev-sans-first:439.37 15:17:54 INFO - PROCESS | 3369 | Values: 2566.2 2620.9 2629.6 2638.9 2659.5 4453.6 4529.8 4532.5 4543.2 4551.3 4616.0 4648.9 4671.4 4693.0 4697.2 4185.0 4186.2 4206.5 4239.7 4385.6 4261.1 4341.0 4342.3 4355.2 4386.5 4116.9 4157.2 4200.7 4234.5 4273.3 4234.2 4242.3 4243.7 4247.6 4287.8 4227.5 4236.2 4241.8 4267.2 4275.6 4398.4 4551.3 4585.3 4624.0 4636.7 4846.8 4877.3 4880.7 4881.4 4900.3 4801.1 4900.0 4904.8 4917.0 4958.7 4571.0 4609.4 4610.7 4651.0 4656.8 4920.4 4947.6 4948.0 4964.4 4997.7 4755.8 4759.4 4760.3 4770.9 4850.1 4989.0 4991.2 5024.8 5046.5 5058.7 4934.1 4939.7 4948.8 4958.5 5017.8 4740.8 4913.3 4938.7 4944.9 4993.9 4100.6 4144.4 4215.1 4218.3 4219.3 3616.7 3630.5 3634.5 3664.2 3666.4 4208.4 4215.0 4226.3 4227.0 4262.6 4767.9 4927.1 4963.1 4997.6 5008.0 4200.5 4218.9 4221.2 4222.3 4250.5 4423.3 4424.9 4429.4 4450.7 4475.5 4560.6 4694.6 4734.7 4767.5 4782.1 4914.2 4927.4 4934.0 4940.8 4996.6 4436.3 4684.1 4688.8 4693.1 4742.9 4780.9 4806.3 4824.8 4831.1 4850.1 4836.0 4847.2 4863.9 4867.0 4933.9 4695.2 4710.5 4736.3 4751.7 4757.6 4707.3 4720.3 4726.4 4761.5 4767.6 4649.0 4690.7 4696.2 4709.2 4737.4 4663.8 4768.4 4799.1 4808.7 4850.6 4698.1 4716.7 4716.9 4757.1 4766.6 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#1] ext.html Cycles:180 Average:44292.51 Median:189061.16 stddev:79628.51 (42.1%) stddev-sans-first:79784.17 15:17:54 INFO - PROCESS | 3369 | Values: 552.8 566.4 590.5 592.8 607.7 26609.3 27163.3 27234.9 27236.5 27242.5 33979.8 34284.0 35175.6 35203.5 35243.8 7597.0 7812.6 7815.3 7816.1 7821.5 7255.1 7638.2 7804.5 9700.8 10056.8 9650.9 9748.6 9751.5 9758.3 9768.2 9679.7 9764.4 9797.5 9797.9 9800.4 9564.7 9723.7 9732.0 9732.7 9736.3 37149.8 37735.4 37808.2 37808.4 37854.0 3079.2 3082.0 3218.5 3219.5 3266.2 28416.9 28490.4 28593.3 28868.7 29388.0 3318.1 3349.2 3354.3 3377.5 3381.0 244675.0 245189.0 245320.0 245701.0 246386.8 50694.7 51213.2 51358.2 51393.0 51413.7 54678.5 54935.7 55296.4 55357.7 55378.0 13281.3 13535.5 13541.3 13543.7 13544.9 10619.7 10721.2 10795.1 10803.8 10820.0 14782.6 15161.2 15168.6 15284.3 15447.8 5559.4 5820.5 5865.6 5910.6 5993.0 879.1 894.8 929.9 969.0 994.8 27141.5 27944.6 28039.6 28339.9 28593.1 825.4 962.7 973.2 985.2 1008.4 13309.5 13654.7 13891.7 13911.7 13934.7 339639.0 342180.0 342657.0 343713.0 346040.0 47478.5 47965.3 48037.5 48089.3 48209.8 1104.2 1164.0 1252.4 1270.7 1279.7 24518.9 25721.9 27401.3 27752.1 28015.7 36982.6 37578.8 37609.0 37672.2 37684.0 225569.0 230777.0 230797.0 231276.0 518558.0 34692.3 35535.3 36026.6 36178.2 36466.6 35679.3 35908.6 36272.0 36575.8 36825.6 32024.2 33773.3 33999.7 34706.7 34863.0 33101.8 33717.8 33727.2 34006.3 34140.7 34083.1 34409.3 34649.3 34873.8 34910.5 29416.6 30556.2 30692.7 30863.5 30917.0 24485.1 24487.0 24525.4 24902.8 24923.0 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#2] jquery.html Cycles:180 Average:24123.42 Median:391283.50 stddev:65868.01 (16.8%) stddev-sans-first:66028.64 15:17:54 INFO - PROCESS | 3369 | Values: 369.4 373.7 376.2 379.7 383.4 16193.2 16394.3 16590.8 16617.8 16631.4 14691.9 15988.8 16099.2 16123.5 16165.8 4892.4 5030.0 5066.0 5089.2 5092.1 3599.2 3745.5 3749.9 3752.1 5035.8 3832.2 5683.6 5692.4 5697.7 5714.0 5564.8 5695.6 5766.4 5771.5 5786.0 4876.0 5089.4 5129.5 5135.4 5138.7 20471.5 20602.7 20721.2 20781.4 21178.2 1836.3 1914.3 2022.0 2094.0 2540.8 5950.6 5994.6 10816.9 12519.3 12720.7 1771.8 1786.5 1839.5 1857.2 1864.1 66859.0 67207.3 67283.7 67317.0 67991.0 9135.7 9409.8 9424.7 9546.2 9675.1 13076.6 13151.3 13162.4 13169.7 13190.6 6531.7 6727.7 6773.7 6814.0 6825.6 6405.6 6439.6 6447.5 6533.7 6556.1 6024.2 6036.2 6071.7 6091.3 6107.8 1701.3 1749.0 1757.7 1767.2 1771.7 861.2 866.5 917.2 964.3 1024.4 16444.5 17186.7 17258.1 17293.7 17610.6 871.3 893.0 901.1 911.2 944.2 9572.1 9877.4 10088.4 10105.9 10249.4 386883.0 395684.0 405593.0 407038.0 408554.0 65430.0 67925.7 68844.3 69633.0 72037.6 956.9 962.3 971.0 994.0 994.5 14831.2 14890.6 15248.2 15969.4 16145.6 34658.0 35008.0 35343.3 35510.8 35521.6 43581.8 44511.0 45552.5 50086.2 50177.0 7474.9 7686.3 7740.1 7959.0 8011.7 10767.2 10982.5 11364.7 11432.4 11528.9 10102.3 10272.6 10384.2 10500.2 10509.8 9462.9 10104.1 10307.4 10403.3 10635.0 10373.2 10664.9 10799.8 10860.6 10911.0 7752.6 7906.3 7993.2 8172.0 8234.4 9585.2 10159.3 10383.7 10453.5 10937.9 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#3] mootools.html Cycles:180 Average:5096.35 Median:5597.16 stddev:2750.78 (49.1%) stddev-sans-first:2743.23 15:17:54 INFO - PROCESS | 3369 | Values: 1239.7 1368.9 1443.2 1531.5 1733.4 6723.5 7425.8 7655.1 7680.3 7689.8 7421.7 7581.1 7592.7 7593.5 7603.1 1917.5 2194.7 2207.4 2209.6 2259.4 2267.2 2285.1 2287.7 2288.9 2289.1 2213.7 2235.2 2248.0 2256.3 2258.7 1906.6 2171.4 2236.5 2237.9 2239.5 2132.5 2138.1 2145.4 2146.9 2196.9 7525.1 7529.4 7529.5 7585.7 7593.7 4342.4 4475.0 4482.8 4491.2 4541.5 2903.0 2961.5 2973.4 2984.2 3033.3 939.6 942.4 976.1 982.3 992.2 10271.7 10283.8 10283.9 10290.5 10297.0 4127.4 4162.2 4258.4 4385.9 4389.8 8819.6 8830.1 8832.4 8847.5 8872.7 4055.7 4600.2 4627.2 4635.2 4649.4 4062.5 4114.8 4123.9 4127.3 4158.1 3619.3 3630.5 3719.3 3741.3 3761.5 1193.2 1198.6 1214.7 1224.6 1235.4 786.6 870.0 902.3 903.6 912.7 5395.6 5438.6 5525.8 5600.7 5634.4 835.2 863.5 874.7 906.8 943.8 3645.5 3803.6 3829.0 3855.6 3900.9 8629.1 8976.6 9023.3 9055.9 9390.4 9136.5 9146.4 9221.7 9253.6 9268.8 6962.4 7028.1 7032.8 7110.5 7247.3 5545.5 5586.3 5593.6 5640.6 5743.3 8599.8 8733.9 8742.6 8749.0 8764.0 8536.3 8851.1 8880.6 8947.5 8972.1 6031.9 6222.1 6228.5 6722.6 6847.3 6661.7 7140.9 7417.0 7417.7 7426.9 6755.9 6933.4 6966.0 7162.7 7240.2 6867.1 6882.6 6932.7 6986.3 7007.4 6147.5 6158.9 6193.9 6261.2 6340.4 4728.0 4785.2 4865.5 4898.5 4909.8 4899.2 4931.2 4933.4 4957.9 5000.7 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#4] prototype.html Cycles:180 Average:4377.50 Median:5000.20 stddev:1268.15 (25.4%) stddev-sans-first:1234.38 15:17:54 INFO - PROCESS | 3369 | Values: 308.1 309.3 311.6 315.3 315.5 4972.2 4996.8 5003.6 5007.7 5011.7 4979.6 4984.6 4989.4 5006.8 5016.0 3738.4 3832.3 3849.3 3948.8 3996.7 3926.3 3966.8 3973.2 3988.1 3996.4 3688.6 3925.2 3944.1 3944.6 3959.5 3756.7 3884.6 3891.1 3896.8 3914.4 3437.3 3437.8 3451.3 3454.9 3484.8 4799.0 4799.4 4800.6 4824.9 4828.0 4348.8 4489.6 4495.9 4507.7 4510.8 5223.9 5225.8 5230.2 5242.7 5243.0 3770.0 3783.1 3789.8 3790.0 3809.6 5290.8 5424.3 5456.7 5460.7 5513.3 3836.8 3884.1 3885.5 3888.6 3893.8 3933.4 3941.7 3948.9 3962.4 3973.6 4355.8 4451.4 4469.7 4471.8 4473.6 5224.1 5243.9 5255.8 5257.7 5266.6 1357.5 1377.5 1379.2 1379.6 1380.7 879.1 919.7 940.9 941.9 965.8 4561.8 4569.3 4570.7 4570.9 4573.6 5346.4 5346.7 5346.7 5352.1 5355.7 4377.3 4553.0 4561.4 4566.4 4570.3 2846.7 2850.1 2866.0 2870.2 2882.1 5067.6 5081.5 5088.2 5090.2 5092.2 5268.9 5498.1 5500.8 5629.9 5655.1 5195.7 5213.9 5222.5 5230.1 5232.4 5455.8 5462.9 5477.9 5490.0 5503.5 5221.9 5373.9 5395.8 5408.6 5408.9 5196.7 5198.0 5198.1 5204.2 5222.4 3781.9 3811.2 3816.4 3819.4 3824.5 5371.5 5461.3 5478.8 5492.9 5497.7 5279.4 5306.9 5318.9 5321.0 5329.7 5090.6 5229.8 5310.4 5312.7 5315.4 4971.8 5191.4 5199.6 5216.1 5217.3 5130.9 5305.8 5333.4 5361.4 5368.6 5187.4 5199.9 5215.3 5215.6 5225.3 15:17:54 INFO - PROCESS | 3369 | 15:17:54 INFO - PROCESS | 3369 | [#5] yui.html Cycles:180 Average:12345.33 Median:520.31 stddev:13994.43 (2689.7%) stddev-sans-first:14006.32 15:17:54 INFO - PROCESS | 3369 | Values: 691.5 779.6 794.9 802.2 804.0 12250.9 12563.1 12583.8 12586.9 12620.2 12031.4 12091.5 12147.3 12152.9 12171.7 624.0 794.7 806.7 807.3 808.1 762.1 789.1 793.5 793.5 793.8 826.1 833.0 835.1 835.2 835.9 658.1 819.5 828.9 829.3 830.7 621.7 622.9 623.5 623.9 624.0 12207.4 12212.2 12214.6 12223.4 12238.6 12392.3 12924.2 12945.4 13179.6 13378.3 10332.5 10343.5 10412.2 10518.5 10546.4 3218.2 3289.9 3323.2 3417.2 3477.8 42739.1 43022.6 43622.8 43703.3 43814.8 9578.4 9956.9 10016.2 10234.2 10254.4 17286.6 17376.9 17604.6 17645.4 17646.3 6915.0 6977.3 7098.3 7118.3 7145.2 3664.8 3723.6 3729.2 3801.5 3946.4 2928.7 2984.1 2984.4 2987.4 2989.0 496.4 519.1 530.2 532.2 532.5 521.5 581.2 632.9 647.5 681.6 7832.3 8106.3 8203.3 8323.9 8394.1 527.9 594.7 625.7 640.8 657.1 3974.4 3988.3 3997.1 4029.8 4084.7 51411.7 51833.0 52343.0 52456.2 52823.5 44799.0 45558.8 45805.8 45898.3 46354.0 39639.8 39965.6 40757.0 41825.6 41841.8 7764.5 7868.7 7933.8 7945.2 7987.4 28370.1 28435.0 28584.1 28884.6 29356.6 34103.1 34281.7 37076.8 37322.3 38370.8 9248.1 9263.3 9444.4 9464.6 9492.7 10585.2 10670.9 10769.4 10783.5 10837.3 9897.5 10132.8 10229.9 10334.4 10552.1 8569.7 8641.9 8727.1 8815.3 9120.1 9466.9 9669.1 9672.8 9920.0 9957.7 8295.3 8615.6 8700.4 8743.7 8771.3 8569.2 8571.6 8609.9 8659.4 8718.8 15:17:54 INFO - PROCESS | 3369 | -------- Summary: end -------- 15:17:54 INFO - PROCESS | 3369 | 15:17:55 INFO - TEST-INFO | 3369: exit 0 15:17:55 INFO - TEST-OK | dromaeo_css | took 1118089ms 15:17:55 INFO - TEST-START | kraken 15:17:55 INFO - operating with platform_type : linux_ 15:17:55 INFO - Initialising browser for kraken test... 15:17:55 INFO - TEST-INFO | started process 3551 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPl9yFZ/profile http://localhost:43664/getInfo.html) 15:17:59 INFO - PROCESS | 3551 | __metrics Screen width/height:1600/1200 15:17:59 INFO - PROCESS | 3551 | colorDepth:24 15:17:59 INFO - PROCESS | 3551 | Browser inner width/height: 1024/697 15:17:59 INFO - PROCESS | 3551 | __metrics 15:17:59 ERROR - PROCESS | 3551 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 15:18:00 INFO - TEST-INFO | 3551: exit 0 15:18:00 INFO - Browser initialized. 15:18:00 INFO - Running cycle 1/1 for kraken test... 15:18:00 INFO - TEST-INFO | started process 3632 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPl9yFZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:18:12 INFO - PROCESS | 3632 | RSS: Main: 154615808 15:18:12 INFO - PROCESS | 3632 | 15:18:15 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43664/tests/kraken/driver.html?testName=audio-beat-detection) 15:18:16 INFO - PROCESS | 3632 | RSS: Main: 209604608 15:18:16 INFO - PROCESS | 3632 | 15:18:19 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43664/tests/kraken/driver.html?testName=audio-dft) 15:18:19 INFO - PROCESS | 3632 | RSS: Main: 195485696 15:18:19 INFO - PROCESS | 3632 | 15:18:23 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43664/tests/kraken/driver.html?testName=audio-fft) 15:18:23 INFO - PROCESS | 3632 | RSS: Main: 266366976 15:18:23 INFO - PROCESS | 3632 | 15:18:25 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43664/tests/kraken/driver.html?testName=audio-oscillator) 15:18:26 INFO - PROCESS | 3632 | RSS: Main: 173998080 15:18:26 INFO - PROCESS | 3632 | 15:18:28 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:18:29 INFO - PROCESS | 3632 | RSS: Main: 178573312 15:18:29 INFO - PROCESS | 3632 | 15:18:32 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43664/tests/kraken/driver.html?testName=imaging-darkroom) 15:18:32 INFO - PROCESS | 3632 | RSS: Main: 214351872 15:18:32 INFO - PROCESS | 3632 | 15:18:36 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43664/tests/kraken/driver.html?testName=imaging-desaturate) 15:18:36 INFO - PROCESS | 3632 | RSS: Main: 215343104 15:18:36 INFO - PROCESS | 3632 | 15:18:39 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43664/tests/kraken/driver.html?testName=json-parse-financial) 15:18:40 INFO - PROCESS | 3632 | RSS: Main: 215126016 15:18:40 INFO - PROCESS | 3632 | 15:18:42 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:18:42 INFO - PROCESS | 3632 | RSS: Main: 204640256 15:18:42 INFO - PROCESS | 3632 | 15:18:44 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:18:45 INFO - PROCESS | 3632 | RSS: Main: 204836864 15:18:45 INFO - PROCESS | 3632 | 15:18:47 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:18:48 INFO - PROCESS | 3632 | RSS: Main: 219385856 15:18:48 INFO - PROCESS | 3632 | 15:18:50 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:18:51 INFO - PROCESS | 3632 | RSS: Main: 225832960 15:18:51 INFO - PROCESS | 3632 | 15:18:54 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:18:55 INFO - PROCESS | 3632 | RSS: Main: 216023040 15:18:55 INFO - PROCESS | 3632 | 15:18:56 INFO - PROCESS | 3632 | Cycle 1(1): loaded http://localhost:43664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43664/tests/kraken/driver.html?testName=ai-astar) 15:18:57 INFO - PROCESS | 3632 | RSS: Main: 279207936 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | __start_tp_report 15:18:57 INFO - PROCESS | 3632 | _x_x_mozilla_page_load 15:18:57 INFO - PROCESS | 3632 | _x_x_mozilla_page_load_details 15:18:57 INFO - PROCESS | 3632 | |i|pagename|runs| 15:18:57 INFO - PROCESS | 3632 | |0;ai-astar;113;114;110;112;115;116;103;113;112;113 15:18:57 INFO - PROCESS | 3632 | |1;audio-beat-detection;158;131;155;185;134;155;160;137;196;133 15:18:57 INFO - PROCESS | 3632 | |2;audio-dft;162;161;160;161;161;162;160;162;160;161 15:18:57 INFO - PROCESS | 3632 | |3;audio-fft;74;75;127;106;74;74;74;132;103;75 15:18:57 INFO - PROCESS | 3632 | |4;audio-oscillator;95;93;143;94;94;93;156;94;94;148 15:18:57 INFO - PROCESS | 3632 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;118;118 15:18:57 INFO - PROCESS | 3632 | |6;imaging-darkroom;145;146;145;146;146;145;146;146;146;146 15:18:57 INFO - PROCESS | 3632 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 15:18:57 INFO - PROCESS | 3632 | |8;json-parse-financial;65;64;65;64;66;64;65;88;62;63 15:18:57 INFO - PROCESS | 3632 | |9;json-stringify-tinderbox;65;65;66;66;66;65;66;67;65;66 15:18:57 INFO - PROCESS | 3632 | |10;stanford-crypto-aes;84;78;79;78;79;80;80;79;81;81 15:18:57 INFO - PROCESS | 3632 | |11;stanford-crypto-ccm;139;141;135;133;132;131;140;131;166;135 15:18:57 INFO - PROCESS | 3632 | |12;stanford-crypto-pbkdf2;184;177;176;180;180;179;175;179;183;182 15:18:57 INFO - PROCESS | 3632 | |13;stanford-crypto-sha256-iterative;73;74;76;74;71;71;73;81;71;71 15:18:57 INFO - PROCESS | 3632 | __end_tp_report 15:18:57 INFO - PROCESS | 3632 | __start_cc_report 15:18:57 INFO - PROCESS | 3632 | _x_x_mozilla_cycle_collect,1888 15:18:57 INFO - PROCESS | 3632 | __end_cc_report 15:18:57 INFO - PROCESS | 3632 | __startTimestamp1461190737126__endTimestamp 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | ------- Summary: start ------- 15:18:57 INFO - PROCESS | 3632 | Number of tests: 14 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.60 (3.2%) stddev-sans-first:3.81 15:18:57 INFO - PROCESS | 3632 | Values: 113.0 114.0 110.0 112.0 115.0 116.0 103.0 113.0 112.0 113.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#1] audio-beat-detection Cycles:10 Average:154.40 Median:156.50 stddev:22.20 (14.2%) stddev-sans-first:23.51 15:18:57 INFO - PROCESS | 3632 | Values: 158.0 131.0 155.0 185.0 134.0 155.0 160.0 137.0 196.0 133.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.78 15:18:57 INFO - PROCESS | 3632 | Values: 162.0 161.0 160.0 161.0 161.0 162.0 160.0 162.0 160.0 161.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#3] audio-fft Cycles:10 Average:91.40 Median:74.00 stddev:23.60 (31.9%) stddev-sans-first:24.18 15:18:57 INFO - PROCESS | 3632 | Values: 74.0 75.0 127.0 106.0 74.0 74.0 74.0 132.0 103.0 75.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:94.00 stddev:26.82 (28.5%) stddev-sans-first:27.86 15:18:57 INFO - PROCESS | 3632 | Values: 95.0 93.0 143.0 94.0 94.0 93.0 156.0 94.0 94.0 148.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.44 15:18:57 INFO - PROCESS | 3632 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#6] imaging-darkroom Cycles:10 Average:145.70 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 15:18:57 INFO - PROCESS | 3632 | Values: 145.0 146.0 145.0 146.0 146.0 145.0 146.0 146.0 146.0 146.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 15:18:57 INFO - PROCESS | 3632 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.00 stddev:7.60 (11.7%) stddev-sans-first:8.04 15:18:57 INFO - PROCESS | 3632 | Values: 65.0 64.0 65.0 64.0 66.0 64.0 65.0 88.0 62.0 63.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 15:18:57 INFO - PROCESS | 3632 | Values: 65.0 65.0 66.0 66.0 66.0 65.0 66.0 67.0 65.0 66.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#10] stanford-crypto-aes Cycles:10 Average:79.90 Median:80.00 stddev:1.79 (2.2%) stddev-sans-first:1.13 15:18:57 INFO - PROCESS | 3632 | Values: 84.0 78.0 79.0 78.0 79.0 80.0 80.0 79.0 81.0 81.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#11] stanford-crypto-ccm Cycles:10 Average:138.30 Median:137.00 stddev:10.40 (7.6%) stddev-sans-first:11.03 15:18:57 INFO - PROCESS | 3632 | Values: 139.0 141.0 135.0 133.0 132.0 131.0 140.0 131.0 166.0 135.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.50 Median:180.00 stddev:2.95 (1.6%) stddev-sans-first:2.65 15:18:57 INFO - PROCESS | 3632 | Values: 184.0 177.0 176.0 180.0 180.0 179.0 175.0 179.0 183.0 182.0 15:18:57 INFO - PROCESS | 3632 | 15:18:57 INFO - PROCESS | 3632 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.50 Median:73.50 stddev:3.14 (4.3%) stddev-sans-first:3.32 15:18:57 INFO - PROCESS | 3632 | Values: 73.0 74.0 76.0 74.0 71.0 71.0 73.0 81.0 71.0 71.0 15:18:57 INFO - PROCESS | 3632 | -------- Summary: end -------- 15:18:57 INFO - PROCESS | 3632 | 15:18:58 INFO - TEST-INFO | 3632: exit 0 15:18:58 INFO - TEST-OK | kraken | took 63103ms 15:18:58 INFO - SUITE-END | took 1181s 15:18:58 INFO - Completed test suite (00:19:41) 15:18:58 INFO - javascript benchmark 15:18:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2566.1531694540804, 2620.908268210614, 2629.6187052877344, 2638.8944442222314, 2659.4681063787243, 4453.576910193527, 4529.796159172837, 4532.501424843269, 4543.182227199103, 4551.2717965125585, 4616.0, 4648.860534183971, 4671.392718946532, 4693.037927224919, 4697.17799385108, 4185.016521117543, 4186.204621121992, 4206.537280899099, 4239.745615263078, 4385.583369579885, 4261.147770445908, 4340.9565904341025, 4342.305231162999, 4355.150745604608, 4386.517483076859, 4116.855910043164, 4157.210130075276, 4200.684948628865, 4234.534201237861, 4273.273543497582, 4234.195502854479, 4242.2576049191575, 4243.745375277463, 4247.617714405718, 4287.849925252601, 4227.471566054243, 4236.173946080516, 4241.766702831343, 4267.167902259061, 4275.615194632498, 4398.3842262083335, 4551.317302404633, 4585.28928016158, 4624.028953919681, 4636.675432719711, 4846.830360937385, 4877.317175595419, 4880.707157570557, 4881.414230292387, 4900.31395604612, 4801.063792560452, 4900.044491324194, 4904.754762261872, 4916.975415122902, 4958.702477851304, 4570.977145114286, 4609.354690343354, 4610.677252592353, 4650.976745116287, 4656.767161641972, 4920.384951881015, 4947.579455746302, 4948.035133149074, 4964.429090654548, 4997.675151115166, 4755.785989630475, 4759.405074365704, 4760.309755085494, 4770.856874293777, 4850.1269771441475, 4989.0, 4991.176455884811, 5024.84428581421, 5046.470120637354, 5058.671186372874, 4934.136526107916, 4939.703617782944, 4948.752562371867, 4958.528939750718, 5017.8243761468175, 4740.834070807505, 4913.336699545515, 4938.728369939688, 4944.9258261126115, 4993.850184494471, 4100.630943215125, 4144.44050053245, 4215.072684009513, 4218.346156345771, 4219.282721937278, 3616.674499295076, 3630.546181727284, 3634.4548317752547, 3664.193877346979, 3666.431703086026, 4208.368744688321, 4215.0, 4226.260404429274, 4226.978865105655, 4262.6376757975295, 4767.904641907212, 4927.137750893579, 4963.106640804617, 4997.625178111656, 5007.974960125176, 4200.537940826506, 4218.915621687549, 4221.155768846243, 4222.345536441856, 4250.468691413574, 4423.336499525097, 4424.889377765518, 4429.446319210098, 4450.666200035011, 4475.462944446622, 4560.612347950395, 4694.64790140734, 4734.715917044989, 4767.475577686382, 4782.0914026334885, 4914.189158788759, 4927.359443272351, 4934.0, 4940.75296235194, 4996.575291100297, 4436.334549817553, 4684.110019096361, 4688.765561721969, 4693.131770622445, 4742.881427964328, 4780.904381912273, 4806.303086052572, 4824.782884770124, 4831.106245344622, 4850.102730994778, 4835.95164048369, 4847.200211964986, 4863.878403039952, 4867.0, 4933.901321973469, 4695.201815691409, 4710.528947105262, 4736.313234580897, 4751.714897106184, 4757.643176761688, 4707.317438971399, 4720.339152518582, 4726.409198850144, 4761.452432970253, 4767.642426818072, 4648.953510464988, 4690.695104818176, 4696.2486002239475, 4709.152352576569, 4737.360456338351, 4663.836765713184, 4768.356271903249, 4799.088173247072, 4808.735519546459, 4850.563449289581, 4698.060387922497, 4716.716996980193, 4716.905661886674, 4757.14371413149, 4766.571008609242], "value": 4515.794172950989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.770100415272, 566.4363957861926, 590.5334785519441, 592.8399332180309, 607.6840043177546, 26609.334766630844, 27163.320916977085, 27234.86382568087, 27236.45527089457, 27242.45515089697, 33979.83010084946, 34284.0, 35175.64824351756, 35203.471947920734, 35243.82378088106, 7597.0, 7812.609369531529, 7815.25755053269, 7816.140224575321, 7821.491603045813, 7255.09311336083, 7638.159802421729, 7804.453688241825, 9700.805983880318, 10056.849147262797, 9650.855237171449, 9748.610055597768, 9751.463669498211, 9758.268129890252, 9768.169705575036, 9679.661211857587, 9764.414135151914, 9797.510124493818, 9797.853032204523, 9800.411975281506, 9564.713058608253, 9723.708288751348, 9732.026797320212, 9732.70801875945, 9736.318457707963, 37149.814250928575, 37735.35852490327, 37808.243835123416, 37808.43287350692, 37854.0, 3079.1532328609587, 3082.04456618449, 3218.5333126696496, 3219.4526930421885, 3266.199781053633, 28416.94832329023, 28490.430191396055, 28593.285167870763, 28868.73584548019, 29388.0, 3318.1206980150278, 3349.246419555605, 3354.3459025490038, 3377.4764911438765, 3380.9830950845335, 244675.0, 245189.0, 245320.0, 245701.0, 246386.76806616032, 50694.74652626713, 51213.231801523005, 51358.22962655563, 51393.0, 51413.7429312851, 54678.45321546813, 54935.72532137394, 55296.447035529935, 55357.72321138449, 55378.0, 13281.335933203301, 13535.526256580972, 13541.322933853267, 13543.661408464866, 13544.932275338757, 10619.681409557727, 10721.249512534048, 10795.136389088853, 10803.783924321628, 10820.02619764225, 14782.556523304318, 15161.241937903282, 15168.620784480256, 15284.312205950759, 15447.845521544641, 5559.360673522516, 5820.476157145792, 5865.589408741347, 5910.645361278337, 5992.970035149797, 879.1208791208791, 894.8389289927745, 929.8884133903839, 969.0019280141465, 994.786120983992, 27141.457170856473, 27944.580831287545, 28039.579406308923, 28339.858300708365, 28593.14220573386, 825.3933358981144, 962.6919385796477, 973.2262851033446, 985.1626117799813, 1008.369768894441, 13309.467621295233, 13654.726905461835, 13891.722165556632, 13911.721765564835, 13934.651633709036, 339639.0, 342180.0, 342657.0, 343713.0, 346040.0, 47478.5252147481, 47965.280520792214, 48037.519624804, 48089.27866082011, 48209.758951205724, 1104.216006635282, 1163.953441862316, 1252.3612957391795, 1270.6950331920457, 1279.654493286826, 24518.877405612857, 25721.871390642926, 27401.314967125185, 27752.14139973003, 28015.719842802126, 36982.63017369792, 37578.812105939294, 37609.0, 37672.246555069294, 37684.0, 225569.0, 230777.0, 230797.0, 231276.0, 518558.0, 34692.30615387729, 35535.28929421449, 36026.63973360233, 36178.20128886534, 36466.63533364632, 35679.28641427105, 35908.64091359053, 36272.0, 36575.817120914224, 36825.63174368222, 32024.199395015312, 33773.3245335087, 33999.66000340064, 34706.652933470345, 34863.0, 33101.834490827394, 33717.83141084279, 33727.15682107967, 34006.3198736019, 34140.658593414744, 34083.14792130217, 34409.311813764085, 34649.30701386009, 34873.82563087168, 34910.476342855385, 29416.55875161917, 30556.236094097825, 30692.693073069877, 30863.524788905033, 30917.0, 24485.14301999493, 24487.0, 24525.38686532851, 24902.750972490045, 24923.0], "value": 17129.850754117495, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [369.4458312531204, 373.674902834534, 376.1930658737009, 379.7190079341287, 383.37127111537103, 16193.218745937953, 16394.26225819838, 16590.83409165908, 16617.83382166178, 16631.41790037349, 14691.92654036731, 15988.84011159888, 16099.19504024797, 16123.516294511184, 16165.757513637305, 4892.3639926809465, 5030.019146266462, 5065.974670126662, 5089.211172268304, 5092.083424983502, 3599.226166374229, 3745.45690874823, 3749.9250014999684, 3752.08074021865, 5035.823746168885, 3832.156925476391, 5683.573731970118, 5692.430756924316, 5697.74360153792, 5714.0, 5564.777408903639, 5695.601307908448, 5766.365699773021, 5771.451712087345, 5786.0, 4875.951240487585, 5089.41471730752, 5129.461406552296, 5135.35808023997, 5138.691678499302, 20471.48821279465, 20602.690959635616, 20721.159097905682, 20781.376558703265, 21178.152873885025, 1836.3113832312883, 1914.3108480946848, 2021.9696704549444, 2094.0158125680905, 2540.7840333571667, 5950.553708471882, 5994.550408719363, 10816.891831081668, 12519.311437870914, 12720.681982950407, 1771.7785276840395, 1786.4640607817732, 1839.4941391117416, 1857.201403396539, 1864.0679660169915, 66859.0, 67207.32792672109, 67283.66358168177, 67317.0, 67991.0, 9135.680251191176, 9409.764755881159, 9424.717258482257, 9546.18857397115, 9675.129238368581, 13076.607701768962, 13151.342432878319, 13162.407691653898, 13169.73660526784, 13190.559746446746, 6531.673416329165, 6727.730890764413, 6773.695183716744, 6813.965930170318, 6825.590464572141, 6405.583637063669, 6439.581427207217, 6447.484201263887, 6533.673316334164, 6556.147700798961, 6024.186734790747, 6036.215292012011, 6071.726772295257, 6091.284316566891, 6107.816765497042, 1701.2939630053636, 1748.9650206995789, 1757.7099778536654, 1767.169430367725, 1771.663383957044, 861.1517655109712, 866.4714524140269, 917.2111983694018, 964.2864280432569, 1024.4365598920565, 16444.506664800076, 17186.74219886703, 17258.050807205473, 17293.740593891103, 17610.64778704419, 871.285545852395, 892.9953801972781, 901.121406628532, 911.2300106410073, 944.2493217891792, 9572.138507534355, 9877.357971731815, 10088.394696318244, 10105.898941010495, 10249.436281004617, 386883.0, 395684.0, 405593.0, 407038.0, 408554.0, 65430.0, 67925.66037169783, 68844.31155688479, 69633.0, 72037.6398118006, 956.9234461243084, 962.2975228083399, 970.9514524273758, 993.9503024848729, 994.5126887824914, 14831.184284864004, 14890.553283401516, 15248.237588120328, 15969.361225550847, 16145.596360090622, 34658.0, 35008.0, 35343.29313413769, 35510.82244588761, 35521.64478355287, 43581.78209109061, 44511.0, 45552.54447455483, 50086.24870626871, 50177.0, 7474.925250747423, 7686.3082322591235, 7740.064983754061, 7959.0, 8011.719589814562, 10767.192460565333, 10982.450877455936, 11364.693060298172, 11432.428378580871, 11528.884711152781, 10102.292839501164, 10272.589096436059, 10384.221183411426, 10500.159987200852, 10509.842352364874, 9462.858057129011, 10104.141148002502, 10307.433091180057, 10403.323783954018, 10635.042846143884, 10373.222008349254, 10664.946675266574, 10799.784004320027, 10860.565577376816, 10911.0, 7752.604531184441, 7906.288434040964, 7993.1607181247455, 8172.019357676879, 8234.382421318305, 9585.233181345337, 10159.288849780445, 10383.688489345332, 10453.529591168264, 10937.945310273397], "value": 8176.449003359926, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1239.727260002799, 1368.890488760899, 1443.1846007006043, 1531.471642283412, 1733.393312340681, 6723.529352945296, 7425.777226683194, 7655.08139023318, 7680.3087722105, 7689.846203075942, 7421.703131874719, 7581.052368453943, 7592.658330375132, 7593.468457207998, 7603.087629484469, 1917.453525745163, 2194.692743015979, 2207.3598656389668, 2209.591225623265, 2259.401258666455, 2267.1724820440586, 2285.108807565051, 2287.656851472284, 2288.8855557222155, 2289.095807156172, 2213.7232845894264, 2235.2065016919005, 2247.9662805057856, 2256.277991042859, 2258.6837842702034, 1906.5996140810446, 2171.4028642123308, 2236.4856083100976, 2237.9216727414623, 2239.5185035217505, 2132.4988627672483, 2138.101997161196, 2145.410012246629, 2146.9141234350764, 2196.879171645559, 7525.096988361377, 7529.360004399633, 7529.5482271063365, 7585.696572137108, 7593.696252149907, 4342.435483387139, 4474.977625111854, 4482.843100491467, 4491.191585514606, 4541.45502539694, 2902.9854850725824, 2961.496545587234, 2973.405318936221, 2984.2091845660916, 3033.3326668132977, 939.6429356844424, 942.3686130292721, 976.0581039297041, 982.3172894838091, 992.161623428202, 10271.743206419824, 10283.794324113476, 10283.948580257125, 10290.485475726184, 10297.02178293061, 4127.360259159835, 4162.229987452331, 4258.382534532538, 4385.912281754347, 4389.84635537761, 8819.647214111365, 8830.116988301246, 8832.425892316978, 8847.46915185091, 8872.73381798547, 4055.6755459563165, 4600.21796294624, 4627.213373726475, 4635.235186194308, 4649.418822647169, 4062.4921884764403, 4114.794260286973, 4123.9381409278885, 4127.33962565994, 4158.147579746144, 3619.2942376236906, 3630.546181727284, 3719.274741425396, 3741.270452261783, 3761.5110035695184, 1193.2184419205435, 1198.6164427383328, 1214.6963259185204, 1224.589762429596, 1235.43170141734, 786.5595266650694, 869.9956500217459, 902.2826852652157, 903.6475774447971, 912.7124955638952, 5395.595330350239, 5438.619296649196, 5525.834224973257, 5600.747966341524, 5634.352049514277, 835.2482765511089, 863.4560227056913, 874.6807415293372, 906.7551761024487, 943.8442656961524, 3645.453182022665, 3803.5625903020955, 3828.980855095707, 3855.575886652466, 3900.863469778601, 8629.137086291446, 8976.551172441352, 9023.323250756219, 9055.864162037575, 9390.389624674512, 9136.451812891248, 9146.399380108454, 9221.677241296522, 9253.583588738524, 9268.841394825648, 6962.408195303355, 7028.0863487746265, 7032.789016329519, 7110.537815042006, 7247.275272472816, 5545.528630066328, 5586.329640443173, 5593.580481463825, 5640.633358831663, 5743.282089738783, 8599.785005374915, 8733.868991964999, 8742.56287185651, 8748.956255218684, 8764.0, 8536.317094632539, 8851.114888511098, 8880.644774208959, 8947.463152210888, 8972.057933917105, 6031.909521357095, 6222.128901953821, 6228.501719862491, 6722.630255335808, 6847.349501797321, 6661.700223489857, 7140.9285907140265, 7416.961625372344, 7417.666205020679, 7426.888596671162, 6755.864882702417, 6933.375996160168, 6965.965170174117, 7162.677679504331, 7240.239774823778, 6867.141607299088, 6882.5870447773295, 6932.688029038806, 6986.336298051677, 7007.369336759716, 6147.477464415575, 6158.876822463615, 6193.876122477615, 6261.217347831521, 6340.397662222082, 4728.0, 4785.186518291968, 4865.537773911473, 4898.53463920927, 4909.828156014522, 4899.16714158601, 4931.211006238985, 4933.358663373739, 4957.851264462072, 5000.699958002531], "value": 4153.575068912973, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.14028859482045, 309.302522811061, 311.56847765844316, 315.3283506131939, 315.5424634280294, 4972.179590367594, 4996.825111121116, 5003.574696150827, 5007.699538027712, 5011.69929804212, 4979.551840334369, 4984.551390374865, 4989.351384320043, 5006.774695138718, 5015.9749201254035, 3738.4392341148773, 3832.310184166849, 3849.2878817418728, 3948.763074215542, 3996.7402118862183, 3926.27363937671, 3966.7619942803526, 3973.1656352165937, 3988.142549351903, 3996.3605823068315, 3688.6311368863035, 3925.234579257046, 3944.1322908959983, 3944.644981951624, 3959.524857017162, 3756.6806821420214, 3884.553276373225, 3891.105045839473, 3896.8246428910625, 3914.373700207953, 3437.295354452331, 3437.8281085945605, 3451.3097380523996, 3454.913627159316, 3484.8431820568135, 4798.976005119952, 4799.3760811094335, 4800.567948884583, 4824.879378015543, 4827.951720482785, 4348.804303806336, 4489.595936365743, 4495.943453288474, 4507.684462087655, 4510.774461276923, 5223.921641175385, 5225.843224703265, 5230.21546767984, 5242.7378631068295, 5242.973785131088, 3769.9821048317076, 3783.0920579061103, 3789.8484060637543, 3790.0, 3809.561900381464, 5290.814821481268, 5424.321959755031, 5456.727163641802, 5460.726963651841, 5513.3108361454815, 3836.76979381238, 3884.0678237222864, 3885.514310711161, 3888.5528164260904, 3893.824777885002, 3933.449317095609, 3941.704372172041, 3948.940765888514, 3962.3858301962664, 3973.642372186517, 4355.782210889506, 4451.399061126771, 4469.687121901436, 4471.837322296162, 4473.619742321939, 5224.111900976843, 5243.947560524422, 5255.842324730264, 5257.658252213594, 5266.552343050884, 1357.4841560207058, 1377.5247539598822, 1379.2276325257687, 1379.6343968848264, 1380.6686395265065, 879.0769691823559, 919.7424721078108, 940.9388389754781, 941.924646028316, 965.7971825916495, 4561.794719237642, 4569.268916973335, 4570.702904311209, 4570.9314360284625, 4573.63410927125, 5346.385165705916, 5346.652467589594, 5346.705931173745, 5352.090144675414, 5355.651882627617, 4377.343398490252, 4552.97723511387, 4561.361409402686, 4566.383538222364, 4570.337301091389, 2846.672632647231, 2850.1307101333878, 2865.9713402865705, 2870.196345023355, 2882.106546970446, 5067.594592432597, 5081.466446023188, 5088.160453525201, 5090.236464530276, 5092.236164575269, 5268.92096618551, 5498.147787093007, 5500.779968801203, 5629.887402251932, 5655.123455864347, 5195.740212989411, 5213.947860521498, 5222.477752224747, 5230.110881150214, 5232.372115346183, 5455.8363249102595, 5462.945370546244, 5477.890442191054, 5490.0, 5503.504684578407, 5221.947780522298, 5373.865653358697, 5395.81114660985, 5408.648437851684, 5408.891822163613, 5196.68819870809, 5197.997541892646, 5198.090334191425, 5204.200933318622, 5222.42553319127, 3781.905452363713, 3811.2377524495764, 3816.37029890065, 3819.446180303785, 3824.521934758155, 5371.462853714597, 5461.262729531462, 5478.753456094406, 5492.862678433071, 5497.697626630574, 5279.419263880894, 5306.8938621228135, 5318.8936221276135, 5321.0, 5329.7068661224, 5090.618203634816, 5229.764660590206, 5310.3893052297935, 5312.7343632818975, 5315.388730295911, 4971.81240254287, 5191.351081114861, 5199.610029247746, 5216.087184742579, 5217.295665085317, 5130.923036154535, 5305.806193606562, 5333.43998880112, 5361.35663720356, 5368.597355198453, 5187.403448603459, 5199.948000520098, 5215.29593504872, 5215.5827533797965, 5225.268462415341], "value": 3977.8557777772958, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.4537515362864, 779.6438467726718, 794.9125596184418, 802.193795235788, 804.0150815251314, 12250.877491225085, 12563.120581559271, 12583.811242831365, 12586.937065314673, 12620.179688320264, 12031.398430078483, 12091.516339346437, 12147.271163730182, 12152.939235303833, 12171.695707607314, 623.9594426362295, 794.749653859034, 806.7136166660839, 807.3379828540599, 808.0989696488432, 762.1387831750114, 789.0925435748906, 793.4763056382789, 793.5040599625235, 793.8253584211465, 826.1449399871104, 833.017039892926, 835.1398059998212, 835.1690068381969, 835.9373047021468, 658.1148355461896, 819.5451524403953, 828.9419740618159, 829.3489610655637, 830.7466222802074, 621.7046902721171, 622.9065640153968, 623.5043140703152, 623.9126522286883, 623.9500839932795, 12207.389630518439, 12212.206206596631, 12214.57248996281, 12223.388830558437, 12238.632841014783, 12392.31842248676, 12924.224546527239, 12945.352732363439, 13179.55024947255, 13378.264195469244, 10332.535035923327, 10343.482825858751, 10412.219083568763, 10518.526666300035, 10546.36721796687, 3218.1793642620983, 3289.9342013159603, 3323.21904352477, 3417.248205394834, 3477.7739446935866, 42739.14521709579, 43022.56977430217, 43622.781886090364, 43703.34444983296, 43814.78092609548, 9578.425294482353, 9956.850647240297, 10016.248781341283, 10234.232432567587, 10254.384736915808, 17286.567835803955, 17376.913115434596, 17604.647907041788, 17645.38241161579, 17646.294148233927, 6914.997325387791, 6977.33715297046, 7098.3256590623805, 7118.28817118284, 7145.178304494945, 3664.76179048361, 3723.6090210528046, 3729.2355067211156, 3801.4867992820614, 3946.4474973503734, 2928.7217714317107, 2984.134600965739, 2984.358362951976, 2987.3726517431583, 2988.9850550747105, 496.3993567783023, 519.1071357265497, 530.1544037260563, 532.1538753382141, 532.48615086441, 521.5045706578766, 581.1776336483828, 632.8892443822313, 647.5167731748702, 681.5910453727723, 7832.334251588565, 8106.310963568163, 8203.261706446448, 8323.916760832435, 8394.118617545191, 527.860117068977, 594.6848170469658, 625.6558892609047, 640.7533099756628, 657.0505619380045, 3974.364101743707, 3988.2861525589087, 3997.1006523532556, 4029.778362190049, 4084.6936479764136, 51411.742941285804, 51833.0, 52343.0, 52456.21315680268, 52823.47176528262, 44799.0, 45558.772206138754, 45805.7709711456, 45898.311525327146, 46354.0, 39639.80180099081, 39965.60034399677, 40757.0, 41825.581744183386, 41841.79079104585, 7764.495307804975, 7868.685252589832, 7933.801654958672, 7945.245201705829, 7987.440879138405, 28370.148895533166, 28435.0, 28584.142475725763, 28884.566731499464, 29356.559651604817, 34103.147421313675, 34281.657183427844, 37076.81461592675, 37322.253554929295, 38370.80814596021, 9248.075192480697, 9263.342745677042, 9444.433333999981, 9464.621415143318, 9492.715218543455, 10585.176196725939, 10670.89329106699, 10769.40768257722, 10783.460826958777, 10837.349759014169, 9897.50512474359, 10132.848007279748, 10229.948850255998, 10334.379937203792, 10552.103071239031, 8569.65721371163, 8641.913580864111, 8727.127287271222, 8815.294776417742, 9120.087991201091, 9466.905330946602, 9669.129778319984, 9672.77526168971, 9920.0, 9957.651482198089, 8295.294899933331, 8615.569221538773, 8700.390972631854, 8743.737687869374, 8771.298296136167, 8569.228769410784, 8571.614277357408, 8609.870851937101, 8659.437136586102, 8718.782030449289], "value": 5812.460069702413, "unit": "score"}], "name": "dromaeo_css", "value": 6269.821370703011, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 110.0, 112.0, 115.0, 116.0, 103.0, 113.0, 112.0, 113.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 131.0, 155.0, 185.0, 134.0, 155.0, 160.0, 137.0, 196.0, 133.0], "value": 154.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 161.0, 161.0, 162.0, 160.0, 162.0, 160.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 127.0, 106.0, 74.0, 74.0, 74.0, 132.0, 103.0, 75.0], "value": 91.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 93.0, 143.0, 94.0, 94.0, 93.0, 156.0, 94.0, 94.0, 148.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 145.0, 146.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0], "value": 145.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 66.0, 64.0, 65.0, 88.0, 62.0, 63.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 79.0, 78.0, 79.0, 80.0, 80.0, 79.0, 81.0, 81.0], "value": 79.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 135.0, 133.0, 132.0, 131.0, 140.0, 131.0, 166.0, 135.0], "value": 138.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 177.0, 176.0, 180.0, 180.0, 179.0, 175.0, 179.0, 183.0, 182.0], "value": 179.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 74.0, 76.0, 74.0, 71.0, 71.0, 73.0, 81.0, 71.0, 71.0], "value": 73.5, "unit": "score"}], "name": "kraken", "value": 1590.6, "alertThreshold": 2.0}]} 15:18:58 INFO - Return code: 0 15:18:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:18:58 ERROR - # TBPL SUCCESS # 15:18:58 INFO - Running post-action listener: _resource_record_post_action 15:18:58 INFO - Running post-run listener: _resource_record_post_run 15:18:59 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 7856128; Write bytes: 380805120; Read time: 1616; Write time: 290592 15:18:59 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 169598976; Read time: 180; Write time: 190160 15:18:59 INFO - run-tests - Wall time: 1183s; CPU: 13.0%; Read bytes: 6090752; Write bytes: 211206144; Read time: 1388; Write time: 100432 15:18:59 INFO - Running post-run listener: _upload_blobber_files 15:18:59 INFO - Blob upload gear active. 15:18:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:18:59 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 15:18:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:18:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:18:59 INFO - (blobuploader) - INFO - Open directory for files ... 15:18:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:18:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:18:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:19:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:00 INFO - (blobuploader) - INFO - Done attempting. 15:19:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:19:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:19:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:19:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:19:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:19:01 INFO - (blobuploader) - INFO - Done attempting. 15:19:01 INFO - (blobuploader) - INFO - Iteration through files over. 15:19:01 INFO - Return code: 0 15:19:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:19:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:19:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef599de2975cf665b733e8b19dd52d8f9a351c0931bd8cfe70c6f49854140638f8579019fecc5e88ac4390f2cd0175bc325487e36ffcbb4f249efd6a1e462270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac9ea271d27e3685eae1b0fd8810e14395348ef62e87851a8ca05b323cd9da2601719eae73c6e5a0bee006ed22c8b3fc053b584540430d9f4c7c297591cd9543"} 15:19:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:19:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:19:01 INFO - Contents: 15:19:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef599de2975cf665b733e8b19dd52d8f9a351c0931bd8cfe70c6f49854140638f8579019fecc5e88ac4390f2cd0175bc325487e36ffcbb4f249efd6a1e462270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac9ea271d27e3685eae1b0fd8810e14395348ef62e87851a8ca05b323cd9da2601719eae73c6e5a0bee006ed22c8b3fc053b584540430d9f4c7c297591cd9543"} 15:19:01 INFO - Running post-run listener: copy_logs_to_upload_dir 15:19:01 INFO - Copying logs to upload dir... 15:19:01 INFO - mkdir: /builds/slave/test/build/upload/logs 15:19:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1244.998979 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-04-20 15:19:01.769561) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:19:01.773585) ========= 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-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef599de2975cf665b733e8b19dd52d8f9a351c0931bd8cfe70c6f49854140638f8579019fecc5e88ac4390f2cd0175bc325487e36ffcbb4f249efd6a1e462270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac9ea271d27e3685eae1b0fd8810e14395348ef62e87851a8ca05b323cd9da2601719eae73c6e5a0bee006ed22c8b3fc053b584540430d9f4c7c297591cd9543"} build_url:https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011074 build_url: 'https://queue.taskcluster.net/v1/task/JOSWLQrCSoiR18v_GH_v5A/artifacts/public/build/firefox-48.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef599de2975cf665b733e8b19dd52d8f9a351c0931bd8cfe70c6f49854140638f8579019fecc5e88ac4390f2cd0175bc325487e36ffcbb4f249efd6a1e462270", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ac9ea271d27e3685eae1b0fd8810e14395348ef62e87851a8ca05b323cd9da2601719eae73c6e5a0bee006ed22c8b3fc053b584540430d9f4c7c297591cd9543"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 15:19:01.798627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:19:01.798977) ========= 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-1461188973.122163-1519280798 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004402 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 15:19:01.882178) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:19:01.882495) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 15:19:01.882900) ========= ========= Total master_lag: 0.22 =========