builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-042 starttime: 1463176404.69 results: success (0) buildid: 20160513141634 builduid: a8965abb3454426595cc8dd6460e1ea5 revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.692362) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.692834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.693110) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.712657) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.713069) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-05-13 14:53:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 87.8M=0s 2016-05-13 14:53:24 (87.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.132142 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.859608) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.859944) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019564 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.911340) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:24.911785) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c4a209a8e2a8483f71182ecfa6044b830fd85362 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev c4a209a8e2a8483f71182ecfa6044b830fd85362 --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=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-05-13 14:53:25,012 truncating revision to first 12 chars 2016-05-13 14:53:25,012 Setting DEBUG logging. 2016-05-13 14:53:25,012 attempt 1/10 2016-05-13 14:53:25,012 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c4a209a8e2a8?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-13 14:53:25,292 unpacking tar archive at: fx-team-c4a209a8e2a8/testing/mozharness/ program finished with exit code 0 elapsedTime=0.554875 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:25.480299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:25.480623) ========= script_repo_revision: c4a209a8e2a8483f71182ecfa6044b830fd85362 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:25.481027) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:25.481292) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-13 14:53:25.489902) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-13 14:53:25.490253) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:53:25 INFO - MultiFileLogger online at 20160513 14:53:25 in /builds/slave/test 14:53:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:53:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:53:25 INFO - {'append_to_log': False, 14:53:25 INFO - 'base_work_dir': '/builds/slave/test', 14:53:25 INFO - 'blob_upload_branch': 'Fx-Team', 14:53:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:53:25 INFO - 'branch': 'Fx-Team', 14:53:25 INFO - 'buildbot_json_path': 'buildprops.json', 14:53:25 INFO - 'config_files': ('talos/linux_config.py',), 14:53:25 INFO - 'default_actions': ('clobber', 14:53:25 INFO - 'read-buildbot-config', 14:53:25 INFO - 'download-and-extract', 14:53:25 INFO - 'populate-webroot', 14:53:25 INFO - 'create-virtualenv', 14:53:25 INFO - 'install', 14:53:25 INFO - 'run-tests'), 14:53:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:53:25 INFO - 'download_minidump_stackwalk': True, 14:53:25 INFO - 'download_symbols': 'ondemand', 14:53:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:53:25 INFO - 'tooltool.py': '/tools/tooltool.py', 14:53:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:53:25 INFO - '/tools/misc-python/virtualenv.py')}, 14:53:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:53:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:53:25 INFO - 'installer_path': 'installer.exe', 14:53:25 INFO - 'log_level': 'info', 14:53:25 INFO - 'log_name': 'talos', 14:53:25 INFO - 'log_to_console': True, 14:53:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:53:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:53:25 INFO - 'opt_config_files': (), 14:53:25 INFO - 'pip_index': False, 14:53:25 INFO - 'sps_profile': False, 14:53:25 INFO - 'sps_profile_interval': 0, 14:53:25 INFO - 'suite': 'dromaeojs-e10s', 14:53:25 INFO - 'system_bits': '32', 14:53:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:53:25 INFO - 'title': 'talos-linux64-ix-042', 14:53:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:53:25 INFO - 'use_talos_json': True, 14:53:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:53:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:53:25 INFO - 'work_dir': 'build'} 14:53:25 INFO - ##### 14:53:25 INFO - ##### Running clobber step. 14:53:25 INFO - ##### 14:53:25 INFO - Running pre-action listener: _resource_record_pre_action 14:53:25 INFO - Running main action method: clobber 14:53:25 INFO - rmtree: /builds/slave/test/build 14:53:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:53:26 INFO - Running post-action listener: _resource_record_post_action 14:53:26 INFO - ##### 14:53:26 INFO - ##### Finished clobber step (success) 14:53:26 INFO - ##### 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running read-buildbot-config step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: read_buildbot_config 14:53:26 INFO - Using buildbot properties: 14:53:26 INFO - { 14:53:26 INFO - "project": "", 14:53:26 INFO - "product": "firefox", 14:53:26 INFO - "script_repo_revision": "production", 14:53:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 14:53:26 INFO - "repository": "", 14:53:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 14:53:26 INFO - "buildid": "20160513141634", 14:53:26 INFO - "stage_platform": "linux64-pgo", 14:53:26 INFO - "basedir": "/builds/slave/test", 14:53:26 INFO - "buildnumber": 740, 14:53:26 INFO - "platform": "ubuntu64_hw", 14:53:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 14:53:26 INFO - "slavebuilddir": "test", 14:53:26 INFO - "branch": "fx-team", 14:53:26 INFO - "revision": "c4a209a8e2a8483f71182ecfa6044b830fd85362", 14:53:26 INFO - "slavename": "talos-linux64-ix-042", 14:53:26 INFO - "builduid": "a8965abb3454426595cc8dd6460e1ea5", 14:53:26 INFO - "repo_path": "integration/fx-team" 14:53:26 INFO - } 14:53:26 INFO - Found installer url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2. 14:53:26 INFO - Found a test packages url http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json. 14:53:26 INFO - Running post-action listener: _resource_record_post_action 14:53:26 INFO - ##### 14:53:26 INFO - ##### Finished read-buildbot-config step (success) 14:53:26 INFO - ##### 14:53:26 INFO - ##### 14:53:26 INFO - ##### Running download-and-extract step. 14:53:26 INFO - ##### 14:53:26 INFO - Running pre-action listener: _resource_record_pre_action 14:53:26 INFO - Running main action method: download_and_extract 14:53:26 INFO - mkdir: /builds/slave/test/build/tests 14:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 14:53:26 INFO - Downloaded 1361 bytes. 14:53:26 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.test_packages.json 14:53:26 INFO - Using the following test package requirements: 14:53:26 INFO - {u'common': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:26 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 14:53:26 INFO - u'gtest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.gtest.tests.zip'], 14:53:26 INFO - u'jittest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'jsshell-linux-x86_64.zip'], 14:53:26 INFO - u'mochitest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 14:53:26 INFO - u'mozbase': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'], 14:53:26 INFO - u'reftest': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.reftest.tests.zip'], 14:53:26 INFO - u'talos': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'], 14:53:26 INFO - u'web-platform': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 14:53:26 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 14:53:26 INFO - u'firefox-49.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 14:53:26 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 14:53:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:26 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:26 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:31 INFO - Downloaded 23909523 bytes. 14:53:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:32 INFO - Return code: 0 14:53:32 INFO - Downloading packages: [u'firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 14:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:32 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:32 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip 14:53:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 14:53:32 INFO - Downloaded 23909523 bytes. 14:53:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 14:53:34 INFO - Return code: 0 14:53:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:34 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:53:34 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip 14:53:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 14:53:39 INFO - Downloaded 10840239 bytes. 14:53:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 14:53:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 14:53:39 INFO - Return code: 0 14:53:39 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:53:39 INFO - trying http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:39 INFO - Downloading http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 14:53:51 INFO - Downloaded 58399498 bytes. 14:53:51 INFO - Setting buildbot property build_url to http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:51 INFO - mkdir: /builds/slave/test/properties 14:53:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:53:51 INFO - Writing to file /builds/slave/test/properties/build_url 14:53:51 INFO - Contents: 14:53:51 INFO - build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 14:53:51 INFO - Running post-action listener: _resource_record_post_action 14:53:51 INFO - Running post-action listener: set_extra_try_arguments 14:53:51 INFO - ##### 14:53:51 INFO - ##### Finished download-and-extract step (success) 14:53:51 INFO - ##### 14:53:51 INFO - ##### 14:53:51 INFO - ##### Running populate-webroot step. 14:53:51 INFO - ##### 14:53:51 INFO - Running pre-action listener: _resource_record_pre_action 14:53:51 INFO - Running main action method: populate_webroot 14:53:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:53:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:53:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:53:51 INFO - '--tppagecycles', 14:53:51 INFO - '7'], 14:53:51 INFO - 'tests': ['tsvgm']}}, 14:53:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:53:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:53:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:53:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:53:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:53:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['damp', 'tps']}, 14:53:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'tests': ['damp', 'tps']}, 14:53:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['dromaeo_dom']}, 14:53:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:53:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'other-e10s': {'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['a11yr', 14:53:51 INFO - 'ts_paint', 14:53:51 INFO - 'tpaint', 14:53:51 INFO - 'sessionrestore', 14:53:51 INFO - 'sessionrestore_no_auto_restore', 14:53:51 INFO - 'tabpaint']}, 14:53:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['tsvgx', 14:53:51 INFO - 'tsvgr_opacity', 14:53:51 INFO - 'tart', 14:53:51 INFO - 'tscrollx', 14:53:51 INFO - 'cart']}, 14:53:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:53:51 INFO - 'tsvgr_opacity', 14:53:51 INFO - 'tart', 14:53:51 INFO - 'tscrollx', 14:53:51 INFO - 'cart']}, 14:53:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'talos_options': ['--disable-e10s'], 14:53:51 INFO - 'tests': ['tp5o']}, 14:53:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'tests': ['tp5o']}, 14:53:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'talos_options': ['--disable-e10s', 14:53:51 INFO - '--xperf_path', 14:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:51 INFO - 'tests': ['tp5n']}, 14:53:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:53:51 INFO - 'talos_options': ['--xperf_path', 14:53:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:53:51 INFO - 'tests': ['tp5n']}}, 14:53:51 INFO - 'talos.zip': {'path': '', 14:53:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:53:51 INFO - Running post-action listener: _resource_record_post_action 14:53:51 INFO - ##### 14:53:51 INFO - ##### Finished populate-webroot step (success) 14:53:51 INFO - ##### 14:53:51 INFO - ##### 14:53:51 INFO - ##### Running create-virtualenv step. 14:53:51 INFO - ##### 14:53:51 INFO - Running pre-action listener: _resource_record_pre_action 14:53:51 INFO - Running main action method: create_virtualenv 14:53:51 INFO - Creating virtualenv /builds/slave/test/build/venv 14:53:51 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:53:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:53:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:53:51 INFO - Using real prefix '/usr' 14:53:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:53:52 INFO - Installing distribute.............................................................................................................................................................................................done. 14:53:54 INFO - Installing pip.................done. 14:53:54 INFO - Return code: 0 14:53:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:53:54 INFO - Using env: {'DISPLAY': ':0', 14:53:54 INFO - 'HOME': '/home/cltbld', 14:53:54 INFO - 'LANG': 'en_US.UTF-8', 14:53:54 INFO - 'LANGUAGE': 'en_US:en', 14:53:54 INFO - 'LOGNAME': 'cltbld', 14:53:54 INFO - 'MAIL': '/var/mail/cltbld', 14:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:54 INFO - 'MOZ_NO_REMOTE': '1', 14:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:54 INFO - 'NO_EM_RESTART': '1', 14:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:54 INFO - 'PWD': '/builds/slave/test', 14:53:54 INFO - 'SHELL': '/bin/bash', 14:53:54 INFO - 'SHLVL': '1', 14:53:54 INFO - 'TERM': 'linux', 14:53:54 INFO - 'TMOUT': '86400', 14:53:54 INFO - 'USER': 'cltbld', 14:53:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:54 INFO - '_': '/tools/buildbot/bin/python'} 14:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:54 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:53:54 INFO - Cleaning up... 14:53:54 INFO - Return code: 0 14:53:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:53:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:53:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:53:54 INFO - Using env: {'DISPLAY': ':0', 14:53:54 INFO - 'HOME': '/home/cltbld', 14:53:54 INFO - 'LANG': 'en_US.UTF-8', 14:53:54 INFO - 'LANGUAGE': 'en_US:en', 14:53:54 INFO - 'LOGNAME': 'cltbld', 14:53:54 INFO - 'MAIL': '/var/mail/cltbld', 14:53:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:54 INFO - 'MOZ_NO_REMOTE': '1', 14:53:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:54 INFO - 'NO_EM_RESTART': '1', 14:53:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:54 INFO - 'PWD': '/builds/slave/test', 14:53:54 INFO - 'SHELL': '/bin/bash', 14:53:54 INFO - 'SHLVL': '1', 14:53:54 INFO - 'TERM': 'linux', 14:53:54 INFO - 'TMOUT': '86400', 14:53:54 INFO - 'USER': 'cltbld', 14:53:54 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:53:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:54 INFO - '_': '/tools/buildbot/bin/python'} 14:53:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:54 INFO - Downloading/unpacking psutil>=3.1.1 14:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:53:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:56 INFO - Installing collected packages: psutil 14:53:56 INFO - Running setup.py install for psutil 14:53:56 INFO - building 'psutil._psutil_linux' extension 14:53:56 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:53:56 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:53:56 INFO - building 'psutil._psutil_posix' extension 14:53:56 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:53:57 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:53:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:53:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:53:57 INFO - Successfully installed psutil 14:53:57 INFO - Cleaning up... 14:53:57 INFO - Return code: 0 14:53:57 INFO - Installing mozsystemmonitor==0.1 into virtualenv /builds/slave/test/build/venv 14:53:57 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:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 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:53:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:57 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.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:53:57 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.1'] in /builds/slave/test/build 14:53:57 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.1 14:53:57 INFO - Using env: {'DISPLAY': ':0', 14:53:57 INFO - 'HOME': '/home/cltbld', 14:53:57 INFO - 'LANG': 'en_US.UTF-8', 14:53:57 INFO - 'LANGUAGE': 'en_US:en', 14:53:57 INFO - 'LOGNAME': 'cltbld', 14:53:57 INFO - 'MAIL': '/var/mail/cltbld', 14:53:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:57 INFO - 'MOZ_NO_REMOTE': '1', 14:53:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:57 INFO - 'NO_EM_RESTART': '1', 14:53:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:57 INFO - 'PWD': '/builds/slave/test', 14:53:57 INFO - 'SHELL': '/bin/bash', 14:53:57 INFO - 'SHLVL': '1', 14:53:57 INFO - 'TERM': 'linux', 14:53:57 INFO - 'TMOUT': '86400', 14:53:57 INFO - 'USER': 'cltbld', 14:53:57 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:53:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:57 INFO - '_': '/tools/buildbot/bin/python'} 14:53:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:57 INFO - Downloading/unpacking mozsystemmonitor==0.1 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:59 INFO - Downloading mozsystemmonitor-0.1.tar.gz 14:53:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:53:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.1) 14:53:59 INFO - Installing collected packages: mozsystemmonitor 14:53:59 INFO - Running setup.py install for mozsystemmonitor 14:53:59 INFO - Successfully installed mozsystemmonitor 14:53:59 INFO - Cleaning up... 14:53:59 INFO - Return code: 0 14:53:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:53:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:53:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:53:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:53:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:53:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:53:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:53:59 INFO - Using env: {'DISPLAY': ':0', 14:53:59 INFO - 'HOME': '/home/cltbld', 14:53:59 INFO - 'LANG': 'en_US.UTF-8', 14:53:59 INFO - 'LANGUAGE': 'en_US:en', 14:53:59 INFO - 'LOGNAME': 'cltbld', 14:53:59 INFO - 'MAIL': '/var/mail/cltbld', 14:53:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:53:59 INFO - 'MOZ_NO_REMOTE': '1', 14:53:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:53:59 INFO - 'NO_EM_RESTART': '1', 14:53:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:53:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:53:59 INFO - 'PWD': '/builds/slave/test', 14:53:59 INFO - 'SHELL': '/bin/bash', 14:53:59 INFO - 'SHLVL': '1', 14:53:59 INFO - 'TERM': 'linux', 14:53:59 INFO - 'TMOUT': '86400', 14:53:59 INFO - 'USER': 'cltbld', 14:53:59 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:53:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:53:59 INFO - '_': '/tools/buildbot/bin/python'} 14:53:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:53:59 INFO - Downloading/unpacking blobuploader==1.2.4 14:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:53:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:53:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:53:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:01 INFO - Downloading blobuploader-1.2.4.tar.gz 14:54:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:54:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:54:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:54:02 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:54:02 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:54:02 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:54:02 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:54:02 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:54:02 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:54:02 INFO - Downloading docopt-0.6.1.tar.gz 14:54:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:54:02 INFO - Installing collected packages: blobuploader, requests, docopt 14:54:02 INFO - Running setup.py install for blobuploader 14:54:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:54:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:54:02 INFO - Running setup.py install for requests 14:54:02 INFO - Running setup.py install for docopt 14:54:03 INFO - Successfully installed blobuploader requests docopt 14:54:03 INFO - Cleaning up... 14:54:03 INFO - Return code: 0 14:54:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:03 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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:54:03 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:54:03 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:54:03 INFO - Using env: {'DISPLAY': ':0', 14:54:03 INFO - 'HOME': '/home/cltbld', 14:54:03 INFO - 'LANG': 'en_US.UTF-8', 14:54:03 INFO - 'LANGUAGE': 'en_US:en', 14:54:03 INFO - 'LOGNAME': 'cltbld', 14:54:03 INFO - 'MAIL': '/var/mail/cltbld', 14:54:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:03 INFO - 'MOZ_NO_REMOTE': '1', 14:54:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:03 INFO - 'NO_EM_RESTART': '1', 14:54:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:03 INFO - 'PWD': '/builds/slave/test', 14:54:03 INFO - 'SHELL': '/bin/bash', 14:54:03 INFO - 'SHLVL': '1', 14:54:03 INFO - 'TERM': 'linux', 14:54:03 INFO - 'TMOUT': '86400', 14:54:03 INFO - 'USER': 'cltbld', 14:54:03 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:03 INFO - '_': '/tools/buildbot/bin/python'} 14:54:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:03 INFO - Running setup.py (path:/tmp/pip-65vwsC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:03 INFO - Running setup.py (path:/tmp/pip-uK6bUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:03 INFO - Running setup.py (path:/tmp/pip-fxhu4A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:03 INFO - Running setup.py (path:/tmp/pip-CFt17S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:03 INFO - Running setup.py (path:/tmp/pip-M6LSWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:03 INFO - Running setup.py (path:/tmp/pip-q0lg5j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:03 INFO - Running setup.py (path:/tmp/pip-aftepp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:03 INFO - Running setup.py (path:/tmp/pip-eRgKMu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:03 INFO - Running setup.py (path:/tmp/pip-5qmHpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:03 INFO - Running setup.py (path:/tmp/pip-GqJMRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:03 INFO - Running setup.py (path:/tmp/pip-tIEUZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:04 INFO - Running setup.py (path:/tmp/pip-5ZbBue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:04 INFO - Running setup.py (path:/tmp/pip-vsBZAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:04 INFO - Running setup.py (path:/tmp/pip-bJB8EY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:04 INFO - Running setup.py (path:/tmp/pip-SqGH4l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:04 INFO - Running setup.py (path:/tmp/pip-TZkedQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:04 INFO - Running setup.py (path:/tmp/pip-IxwjU8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:54:04 INFO - Running setup.py install for manifestparser 14:54:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:54:04 INFO - Running setup.py install for mozcrash 14:54:04 INFO - Running setup.py install for mozdebug 14:54:04 INFO - Running setup.py install for mozdevice 14:54:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:54:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:54:04 INFO - Running setup.py install for mozfile 14:54:05 INFO - Running setup.py install for mozhttpd 14:54:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozinfo 14:54:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozInstall 14:54:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozleak 14:54:05 INFO - Running setup.py install for mozlog 14:54:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for moznetwork 14:54:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozprocess 14:54:05 INFO - Running setup.py install for mozprofile 14:54:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozrunner 14:54:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:54:05 INFO - Running setup.py install for mozscreenshot 14:54:06 INFO - Running setup.py install for moztest 14:54:06 INFO - Running setup.py install for mozversion 14:54:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:54:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:54:06 INFO - Cleaning up... 14:54:06 INFO - Return code: 0 14:54:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 14:54:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:06 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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:54:06 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:54:06 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:54:06 INFO - Using env: {'DISPLAY': ':0', 14:54:06 INFO - 'HOME': '/home/cltbld', 14:54:06 INFO - 'LANG': 'en_US.UTF-8', 14:54:06 INFO - 'LANGUAGE': 'en_US:en', 14:54:06 INFO - 'LOGNAME': 'cltbld', 14:54:06 INFO - 'MAIL': '/var/mail/cltbld', 14:54:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:06 INFO - 'MOZ_NO_REMOTE': '1', 14:54:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:06 INFO - 'NO_EM_RESTART': '1', 14:54:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:06 INFO - 'PWD': '/builds/slave/test', 14:54:06 INFO - 'SHELL': '/bin/bash', 14:54:06 INFO - 'SHLVL': '1', 14:54:06 INFO - 'TERM': 'linux', 14:54:06 INFO - 'TMOUT': '86400', 14:54:06 INFO - 'USER': 'cltbld', 14:54:06 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:06 INFO - '_': '/tools/buildbot/bin/python'} 14:54:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:54:06 INFO - Running setup.py (path:/tmp/pip-_0Z7Fo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:54:06 INFO - Running setup.py (path:/tmp/pip-jxvlTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:54:06 INFO - Running setup.py (path:/tmp/pip-VTsIA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:54:06 INFO - Running setup.py (path:/tmp/pip-f2itbT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:54:06 INFO - Running setup.py (path:/tmp/pip-PUsxon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:54:06 INFO - Running setup.py (path:/tmp/pip-fKFsn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:54:06 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:54:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:54:06 INFO - Running setup.py (path:/tmp/pip-qGlL4y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:54:07 INFO - Running setup.py (path:/tmp/pip-Q7GFro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:54:07 INFO - Running setup.py (path:/tmp/pip-VQfnDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:54:07 INFO - Running setup.py (path:/tmp/pip-Z9Fbz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:54:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:54:07 INFO - Running setup.py (path:/tmp/pip-VCE1gV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:54:07 INFO - Running setup.py (path:/tmp/pip-88LrwQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:54:07 INFO - Running setup.py (path:/tmp/pip-ObmWg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:54:07 INFO - Running setup.py (path:/tmp/pip-8Htja8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:07 INFO - Running setup.py (path:/tmp/pip-TnQ8xR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:54:07 INFO - Running setup.py (path:/tmp/pip-YoGoIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:54:07 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:54:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:54:07 INFO - Running setup.py (path:/tmp/pip-opVUuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 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:54:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:09 INFO - Downloading blessings-1.6.tar.gz 14:54:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:54:09 INFO - Installing collected packages: blessings 14:54:09 INFO - Running setup.py install for blessings 14:54:09 INFO - Successfully installed blessings 14:54:09 INFO - Cleaning up... 14:54:09 INFO - Return code: 0 14:54:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:54:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:10 INFO - Reading from file tmpfile_stdout 14:54:10 INFO - Current package versions: 14:54:10 INFO - argparse == 1.2.1 14:54:10 INFO - blessings == 1.6 14:54:10 INFO - blobuploader == 1.2.4 14:54:10 INFO - docopt == 0.6.1 14:54:10 INFO - manifestparser == 1.1 14:54:10 INFO - mozInstall == 1.12 14:54:10 INFO - mozcrash == 0.17 14:54:10 INFO - mozdebug == 0.1 14:54:10 INFO - mozdevice == 0.48 14:54:10 INFO - mozfile == 1.2 14:54:10 INFO - mozhttpd == 0.7 14:54:10 INFO - mozinfo == 0.9 14:54:10 INFO - mozleak == 0.1 14:54:10 INFO - mozlog == 3.2 14:54:10 INFO - moznetwork == 0.27 14:54:10 INFO - mozprocess == 0.22 14:54:10 INFO - mozprofile == 0.28 14:54:10 INFO - mozrunner == 6.11 14:54:10 INFO - mozscreenshot == 0.1 14:54:10 INFO - mozsystemmonitor == 0.1 14:54:10 INFO - moztest == 0.7 14:54:10 INFO - mozversion == 1.4 14:54:10 INFO - psutil == 3.1.1 14:54:10 INFO - requests == 1.2.3 14:54:10 INFO - wsgiref == 0.1.2 14:54:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:54:10 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:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:54:10 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:54:10 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:54:10 INFO - Using env: {'DISPLAY': ':0', 14:54:10 INFO - 'HOME': '/home/cltbld', 14:54:10 INFO - 'LANG': 'en_US.UTF-8', 14:54:10 INFO - 'LANGUAGE': 'en_US:en', 14:54:10 INFO - 'LOGNAME': 'cltbld', 14:54:10 INFO - 'MAIL': '/var/mail/cltbld', 14:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:10 INFO - 'MOZ_NO_REMOTE': '1', 14:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:10 INFO - 'NO_EM_RESTART': '1', 14:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:10 INFO - 'PWD': '/builds/slave/test', 14:54:10 INFO - 'SHELL': '/bin/bash', 14:54:10 INFO - 'SHLVL': '1', 14:54:10 INFO - 'TERM': 'linux', 14:54:10 INFO - 'TMOUT': '86400', 14:54:10 INFO - 'USER': 'cltbld', 14:54:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:10 INFO - '_': '/tools/buildbot/bin/python'} 14:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 INFO - Cleaning up... 14:54:10 INFO - Return code: 0 14:54:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:54:10 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:54:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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:54:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:10 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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:54:10 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:54:10 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:54:10 INFO - Using env: {'DISPLAY': ':0', 14:54:10 INFO - 'HOME': '/home/cltbld', 14:54:10 INFO - 'LANG': 'en_US.UTF-8', 14:54:10 INFO - 'LANGUAGE': 'en_US:en', 14:54:10 INFO - 'LOGNAME': 'cltbld', 14:54:10 INFO - 'MAIL': '/var/mail/cltbld', 14:54:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:10 INFO - 'MOZ_NO_REMOTE': '1', 14:54:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:10 INFO - 'NO_EM_RESTART': '1', 14:54:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:10 INFO - 'PWD': '/builds/slave/test', 14:54:10 INFO - 'SHELL': '/bin/bash', 14:54:10 INFO - 'SHLVL': '1', 14:54:10 INFO - 'TERM': 'linux', 14:54:10 INFO - 'TMOUT': '86400', 14:54:10 INFO - 'USER': 'cltbld', 14:54:10 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:10 INFO - '_': '/tools/buildbot/bin/python'} 14:54:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:10 INFO - Downloading/unpacking jsonschema 14:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:10 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:54:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:54:12 INFO - Downloading/unpacking functools32 (from jsonschema) 14:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:12 INFO - Downloading functools32-3.2.3-2.tar.gz 14:54:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:54:12 INFO - warning: no files found matching '*.txt' 14:54:12 INFO - no previously-included directories found matching 'build' 14:54:12 INFO - no previously-included directories found matching 'dist' 14:54:12 INFO - no previously-included directories found matching '.git*' 14:54:12 INFO - Installing collected packages: jsonschema, functools32 14:54:12 INFO - Running setup.py install for functools32 14:54:12 INFO - warning: no files found matching '*.txt' 14:54:12 INFO - no previously-included directories found matching 'build' 14:54:12 INFO - no previously-included directories found matching 'dist' 14:54:12 INFO - no previously-included directories found matching '.git*' 14:54:13 INFO - Successfully installed jsonschema functools32 14:54:13 INFO - Cleaning up... 14:54:13 INFO - Return code: 0 14:54:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 14:54:13 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:54:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:13 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:54:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:54:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:54:13 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 0x7f205c4c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b118a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2bdd8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, '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': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', '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:54:13 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:54:13 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:54:13 INFO - Using env: {'DISPLAY': ':0', 14:54:13 INFO - 'HOME': '/home/cltbld', 14:54:13 INFO - 'LANG': 'en_US.UTF-8', 14:54:13 INFO - 'LANGUAGE': 'en_US:en', 14:54:13 INFO - 'LOGNAME': 'cltbld', 14:54:13 INFO - 'MAIL': '/var/mail/cltbld', 14:54:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:13 INFO - 'MOZ_NO_REMOTE': '1', 14:54:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:13 INFO - 'NO_EM_RESTART': '1', 14:54:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:13 INFO - 'PWD': '/builds/slave/test', 14:54:13 INFO - 'SHELL': '/bin/bash', 14:54:13 INFO - 'SHLVL': '1', 14:54:13 INFO - 'TERM': 'linux', 14:54:13 INFO - 'TMOUT': '86400', 14:54:13 INFO - 'USER': 'cltbld', 14:54:13 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:13 INFO - '_': '/tools/buildbot/bin/python'} 14:54:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:54:13 INFO - Downloading/unpacking flake8 14:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:13 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:54:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 14:54:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 14:54:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:54:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:54:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:54:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 14:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:15 INFO - no previously-included directories found matching 'docs/_build' 14:54:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 14:54:15 INFO - Running setup.py install for pep8 14:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 14:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 14:54:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 14:54:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 14:54:16 INFO - no previously-included directories found matching 'docs/_build' 14:54:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 14:54:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 14:54:16 INFO - Cleaning up... 14:54:16 INFO - Return code: 0 14:54:16 INFO - Running post-action listener: _resource_record_post_action 14:54:16 INFO - Running post-action listener: _start_resource_monitoring 14:54:16 INFO - Starting resource monitoring. 14:54:16 INFO - ##### 14:54:16 INFO - ##### Finished create-virtualenv step (success) 14:54:16 INFO - ##### 14:54:16 INFO - ##### 14:54:16 INFO - ##### Running install step. 14:54:16 INFO - ##### 14:54:16 INFO - Running pre-action listener: _resource_record_pre_action 14:54:16 INFO - Running main action method: install 14:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:54:16 INFO - Reading from file tmpfile_stdout 14:54:16 INFO - Detecting whether we're running mozinstall >=1.0... 14:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:54:16 INFO - Reading from file tmpfile_stdout 14:54:16 INFO - Output received: 14:54:16 INFO - Usage: mozinstall [options] installer 14:54:16 INFO - Options: 14:54:16 INFO - -h, --help show this help message and exit 14:54:16 INFO - -d DEST, --destination=DEST 14:54:16 INFO - Directory to install application into. [default: 14:54:16 INFO - "/builds/slave/test"] 14:54:16 INFO - --app=APP Application being installed. [default: firefox] 14:54:16 INFO - mkdir: /builds/slave/test/build/application 14:54:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:54:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 14:54:33 INFO - Reading from file tmpfile_stdout 14:54:33 INFO - Output received: 14:54:33 INFO - /builds/slave/test/build/application/firefox/firefox 14:54:33 INFO - Running post-action listener: _resource_record_post_action 14:54:33 INFO - ##### 14:54:33 INFO - ##### Finished install step (success) 14:54:33 INFO - ##### 14:54:33 INFO - ##### 14:54:33 INFO - ##### Running run-tests step. 14:54:33 INFO - ##### 14:54:33 INFO - Running pre-action listener: _resource_record_pre_action 14:54:33 INFO - Running main action method: run_tests 14:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:54:33 INFO - Python 2.7.3 14:54:33 INFO - Return code: 0 14:54:33 INFO - grabbing minidump binary from tooltool 14:54:33 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:54:33 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c6cb20>, '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 0x2c6da20>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c6deb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:54:33 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:54:33 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:54:33 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:54:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:54:33 INFO - Return code: 0 14:54:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:54:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:54:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:54:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:54:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:54:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 14:54:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 14:54:34 INFO - Return code: 0 14:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 14:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 14:54:34 INFO - Using env: {'DISPLAY': ':0', 14:54:34 INFO - 'HOME': '/home/cltbld', 14:54:34 INFO - 'LANG': 'en_US.UTF-8', 14:54:34 INFO - 'LANGUAGE': 'en_US:en', 14:54:34 INFO - 'LOGNAME': 'cltbld', 14:54:34 INFO - 'MAIL': '/var/mail/cltbld', 14:54:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:54:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:54:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:54:34 INFO - 'MOZ_NO_REMOTE': '1', 14:54:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:54:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:54:34 INFO - 'NO_EM_RESTART': '1', 14:54:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:54:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:54:34 INFO - 'PWD': '/builds/slave/test', 14:54:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:54:34 INFO - 'SHELL': '/bin/bash', 14:54:34 INFO - 'SHLVL': '1', 14:54:34 INFO - 'TERM': 'linux', 14:54:34 INFO - 'TMOUT': '86400', 14:54:34 INFO - 'USER': 'cltbld', 14:54:34 INFO - 'XDG_SESSION_COOKIE': '74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475', 14:54:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:54:34 INFO - '_': '/tools/buildbot/bin/python'} 14:54:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 14:54:34 INFO - mozversion application_buildid: 20160513113013 14:54:34 INFO - mozversion application_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 14:54:34 INFO - mozversion application_display_name: Nightly 14:54:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:54:34 INFO - mozversion application_name: Firefox 14:54:34 INFO - mozversion application_remotingname: firefox 14:54:34 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:54:34 INFO - mozversion application_vendor: Mozilla 14:54:34 INFO - mozversion application_version: 49.0a1 14:54:34 INFO - mozversion platform_buildid: 20160513113013 14:54:34 INFO - mozversion platform_changeset: c4a209a8e2a8483f71182ecfa6044b830fd85362 14:54:34 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:54:34 INFO - mozversion platform_version: 49.0a1 14:54:34 INFO - using testdate: 1463176474 14:54:34 INFO - actual date: 1463176474 14:54:34 INFO - starting webserver on 'localhost:46265' 14:54:34 INFO - SUITE-START | Running 2 tests 14:54:34 INFO - TEST-START | dromaeo_css 14:54:34 INFO - operating with platform_type : linux_ 14:54:34 INFO - Initialising browser for dromaeo_css test... 14:54:34 INFO - TEST-INFO | started process 28245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzKDrF3/profile http://localhost:46265/getInfo.html) 14:54:37 INFO - PROCESS | 28245 | 14:54:37 INFO - PROCESS | 28245 | (process:28312): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:54:38 INFO - PROCESS | 28245 | __metrics Screen width/height:1600/1200 14:54:38 INFO - PROCESS | 28245 | colorDepth:24 14:54:38 INFO - PROCESS | 28245 | Browser inner width/height: 1024/697 14:54:38 INFO - PROCESS | 28245 | __metrics 14:54:39 ERROR - PROCESS | 28245 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 14:54:40 INFO - TEST-INFO | 28245: exit 0 14:54:40 INFO - Browser initialized. 14:54:40 INFO - Running cycle 1/1 for dromaeo_css test... 14:54:40 INFO - TEST-INFO | started process 28363 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzKDrF3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:54:41 INFO - PROCESS | 28363 | 14:54:41 INFO - PROCESS | 28363 | (process:28427): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 14:54:51 INFO - PROCESS | 28363 | RSS: Main: 163667968 14:54:51 INFO - PROCESS | 28363 | 14:55:41 INFO - PROCESS | 28363 | 1463176541470 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] 14:57:49 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46265/tests/dromaeo/cssquery-ext.html) 14:57:50 INFO - PROCESS | 28363 | RSS: Main: 167796736 14:57:50 INFO - PROCESS | 28363 | 15:00:52 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-ext.html (next: http://localhost:46265/tests/dromaeo/cssquery-jquery.html) 15:00:52 INFO - PROCESS | 28363 | RSS: Main: 166756352 15:00:52 INFO - PROCESS | 28363 | 15:03:54 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46265/tests/dromaeo/cssquery-mootools.html) 15:03:55 INFO - PROCESS | 28363 | RSS: Main: 167677952 15:03:55 INFO - PROCESS | 28363 | 15:06:57 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46265/tests/dromaeo/cssquery-prototype.html) 15:06:57 INFO - PROCESS | 28363 | RSS: Main: 165421056 15:06:57 INFO - PROCESS | 28363 | 15:10:00 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46265/tests/dromaeo/cssquery-yui.html) 15:10:00 INFO - PROCESS | 28363 | RSS: Main: 166883328 15:10:00 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | Cycle 1(1): loaded http://localhost:46265/tests/dromaeo/cssquery-yui.html (next: http://localhost:46265/tests/dromaeo/cssquery-dojo.html) 15:13:03 INFO - PROCESS | 28363 | RSS: Main: 168402944 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | __start_tp_report 15:13:03 INFO - PROCESS | 28363 | _x_x_mozilla_page_load 15:13:03 INFO - PROCESS | 28363 | _x_x_mozilla_page_load_details 15:13:03 INFO - PROCESS | 28363 | |i|pagename|runs| 15:13:03 INFO - PROCESS | 28363 | |0;dojo.html;3210.117217765114;3246.7077962983326;3256.0720194744504;3272.967270327297;3287.934241315174;5538.695371754557;5571.8328450146455;5637.520810731087;5687.118496633018;5699.829005129853;5443.047466693332;5596.636218645795;5618.971905140479;5625.634333768302;5639.379668236491;5026.3214466047075;5062;5155.561777248939;5178.197379406198;5188.796825301864;922.6421496400068;5091.592672586185;5103.183490641498;5135.024345374367;5148.279240906276;5041.571466425358;5068.493150684939;5089.694618322913;5100.795968161269;5103.9489605103845;5042.117629414838;5077.923831142536;5098.388193416777;5099.36257967754;5102.107131252016;5056.216286475602;5107.591392688613;5143.8456846294675;5143.922841157386;5147.871303217412;5592.105263157916;5609.3268807742925;5625.8593535161945;5654.773809047633;5691.06097493913;5802.419758024206;5880.176775251468;5962.046072628402;6120.296165940885;6141;6000.6399616022745;6006.819795406145;6037.45662890342;6061.272647282311;6102.755889764404;5570.41510641385;5610.074337734269;5642.548596112342;5646.915296270559;5647.407022262685;6024.548158888101;6091.543134264948;6106.358832322631;6108.419700128481;6153.661548614869;5910;5959.4934430573885;5963.254593175853;5964.880702385928;5970.253718285215;6036.577439579275;6047.395260473917;6068.393160683896;6077.604955677867;6087.604305720114;5838.883222335529;5949.434803693643;6008.09878518217;6010.128531362928;6023.759049638053;5872.706364681749;5881;5906.970465147732;5969.194158788595;6025.6083354581815;4522.751248681288;4529.705569137996;4538.205813982539;4547.954520454753;4590.609798167126;3971.523417189898;4017.196560687874;4021.6380525752825;4024.4969378827645;4028.093678922278;5775.595708300462;5815.389384114607;5840;5842.036064049385;5901.291844978544;6080.452759251689;6098.72555734993;6134.2332208473945;6152.692365381713;6165.167702360213;5583.35791383996;5703.201551782754;5781.046127389018;5824.796132135355;5841.94158058414;5161.716105614228;5177.223416487557;5186.092433824066;5189.948100518946;5199.506046925536;6249.625022498573;6260.718267677874;6294.527910406646;6294.748210071637;6301.558890877686;5932.436418540232;5949.910751338647;5979.133025711334;6019.217501724747;6035.094735789667;6139.938600614116;6149.442992437482;6182.196314479089;6220.409061139185;6222.160008398808;5772.9711351442975;5930.34766175729;5935.465808077293;5935.821925342247;5940.702964851654;6001.639901605918;6011.368806275453;6059.545534084873;6062.393760623902;6078.02751559766;5858.326292476419;5916.822495325147;5923.585349025527;5940.316863560746;5960.970195148997;5831.416858314305;5879.853003674943;5901.557383196192;5931.525477961839;5941.643501389931;5536.861578460571;5795.594308398372;5815.244018277597;5895.882082358415;5935.376785437467;5893.381194974466;5923.585349025527;5941.346451890375;5943.52451803846;5968.224130863134;5649.039663257338;5825.70871456417;5829.038208695687;5829.562782791392;5831.562632802642 15:13:03 INFO - PROCESS | 28363 | |1;ext.html;592.2271435776313;624.1573875268388;646.9773557925473;647.9384458476449;667.3493343989611;43472.13055738883;44064.779676101614;44116.999999999956;44277.11445771083;48636.513634863644;45871.54128458723;46453.76773116138;46555.76722116393;46616.30075548869;46730.766346168224;8971.50656713879;9096.499692516942;9115.27077833775;9115.589798459052;9131.041240669734;8902.643894244222;9024.052474490183;9052.23056040234;9061.50161741104;9071.501067441288;9099.818003639923;9100.317476189279;9106.453612783222;9109.68116115936;9127.497987610679;9009.189172974431;9097.727068187965;9111.95444022779;9131.0412406697;9150.130737579986;8742.30061595071;8904.688335908211;8918.821623567557;8937.240334571568;8948.328875334377;43601.78199109016;44062;44096.779516102535;44123.117537649065;44134.55865441337;3705.7035437164964;4208.789560521992;4247.10810729744;4291.420658211133;4494.1461122386645;33289.33421331584;33491.33017339664;33865.492017619756;33894.83052584746;34697.653023469946;4421.624161946238;4519.344695019204;4519.525449827786;4600.401947746805;4671.6262698984;383684;385750;386650;387511;387603;36436.45345319822;37404.81297593495;37457.812710936814;64103.67948160323;65925;38590.228195436495;38780.6121938777;38785;38973;38998.22003559913;15924.92037539805;16093.839061609468;16115.435959741353;16130.67738645244;16146.75779863303;13546.390412431465;13711.588652340446;13717;13770.793438098237;13794.379252933642;8756.693515727047;8767.430117042371;8783.121687831293;8821.206091451671;8863.290936725047;3375;3376.307856889332;3383.9154021149175;3407.914802129917;3447.965610316895;1087.581281206741;1102.9172812039128;1130.4065365683082;1163.203205804027;1211.9091068169746;33710.49434258488;33979.49030764541;34038.31923361519;34118.31763364719;34225.14437139092;1162.6221478019677;1183.8401815754935;1209.9758004839855;1255.4727014653868;1262.6338361874953;17936.282548698167;18021.459356219333;18078.90960545189;18132.365367212085;18153.273869045355;612757;620786;621016;621159;623056;62839.6858015707;63405.68297158484;63808.68095659492;63851.99999999907;63903.36096639067;1430.2920054572844;1430.370636919752;1461.3935216884875;1461.751502244621;1462.4077248714289;30854.228644284074;31660.366792664478;31664;31787.523187152674;32241.012698475377;55157.448425515235;55485;55556;55593.72203138958;55704.442955569924;465172;474303;474778;475148;475911;29444.11667649974;29453.26366840846;29529.704702952695;29621.555676664437;29872;50805.745971269906;51833.96332073262;52155;52394.73802630963;52540.47459525509;41590;43101;43495.565044349154;44160.558394415646;44279.557204428835;42053.579464204966;42191.1561768769;42350.1529969405;43248.783756081015;43505.34741978936;43325;43473.56526434695;44106;44463.77768111139;47090.76454617705;37770.43344349782;37830.24339513249;37961;38250.42624360581;38519.614803851604;29856.253593659465;29957.550636740903;30328.393432130793;30329;30395 15:13:03 INFO - PROCESS | 28363 | |2;jquery.html;388.7473142457404;389.8752399232245;389.94906290365833;394.8696930013095;405.45263893743453;17903.910480447597;19413.902930485347;19503.804961950394;19612.411627651156;20247;19060.904695476504;19311.613767724637;19613.50966225845;19802.30691925783;19903.50241243966;5567.415421380758;5608.747606357723;5822.039363505017;5872.265966754156;5883.3528311885875;5748.511376533;5795.536357091422;5799.73901174446;5800.361960184377;5824.883502329951;5794.62334948227;6270.717817698214;6411.679416029203;6421.839454013663;6459.41865232129;5849.912251316234;6289.842753931189;6390.137331460263;6390.904136437957;6413.743450262007;5520.751566179531;5599.636023658449;5604.215409842625;5638.4925356718095;5655.0386434306265;13632.727345453135;15347.386104555915;22100.2264920727;22287.554248915094;22394.88802555977;2378.7383387827326;2418.661387405765;2441.3652450362856;2520.3699075231193;2906.099109276131;10182.18542516597;10545.050945414872;10996.12031037515;14106.083104598169;14439.494617688331;1966.469053355586;1984.662607356753;1990.0547240061;2054;2059.4851287178208;82381.58809205976;85552.14447855504;85743.5712821432;86138.56930715307;87228.56385718031;10890.891091089146;11018.39398833072;11033.117350611932;11162.274452160584;11273.774524509465;15470.071795692069;15580.298886550132;15591.454299099478;15612.921935390477;15635.218239088;8260.628271727786;8469.491830490191;8477.067522572512;8500.14998500145;8533.487990720576;8146.714864979697;8170.468919520212;8245.95877020623;8269.255766980881;8460.153984601613;4609.7695115244105;4687.6249900007915;4695.624350051988;4727.361806156125;4750.158781737893;1954.7556555430572;1967.3867428708609;1987.125664707553;2025.888576128327;2032.1464984706458;1004.3823048825066;1017.0998666180336;1022.5602990713916;1064.595453727594;1149.431031639327;19022.144003519876;19139.521511962033;19298.32455864038;19590.804091959184;19885.403437896886;1038.6364772329623;1042.9634962776267;1051.4690081508788;1064.095518809006;1085.5223701571442;10567.471626418648;10759.462026898624;10956.945215273872;10968.945155274172;11004.724881878017;490068;496031;496802;511115;516560;95567;96047;96895.51552242193;97066;97344;1047.0367262118868;1060.5704689600725;1069.5507886687453;1082.588616325807;1083.766990097133;16815.243314051142;16937.576560586083;17022.2339994703;17047.488575342264;17335.306587736854;29119;39600.40599391069;39845.2030959385;40995;41997.79001104975;52604.736976314874;54038;58323;58582;58780.70609646924;8545.572721363782;8582.141785821368;8694;8707.521086340312;8980.012198658012;11990.640280791591;12498.000159986997;12791.552295669608;12824.743505129658;13150.473981041034;11442.199046066695;11532.538698452303;11634.301941883514;11707.473163707824;11985.580504682643;11536.538538458703;11541.192116551762;11602.76794464123;11990.280583165038;12087.637370878887;11973.76052478963;12115.81826272589;12116.757664846476;12206.084543659439;12225.44985475638;8207.671693132208;8349;8383.538905360263;8402.453840500348;8404.957975210085;10350.223733219887;11204.607838725606;11221.214514983873;11337.206395552232;11431.771364572496 15:13:03 INFO - PROCESS | 28363 | |3;mootools.html;1537.13152069081;1578.7316156253435;1773.7782777152856;1862.7485289485933;1877.0614692653674;8373.16268373164;9015.188633023026;9408.15326620604;9600.85598716019;9659.80680386392;8915.910840891589;8962.551872406386;8984.416012959153;9074.591643376047;9085.863712044325;2452.798128916827;2480.2063339731294;2484.043643197373;2486.527559763639;2493.5511607910657;2424.75752424757;2434.257551446808;2439.3413778279855;2457.778799908008;2461.126300163443;2377.4888398994212;2392.5334559760854;2408.506256217471;2411.360989337827;2412.7707867752533;2362.2204672458047;2386.474975505386;2389.450426401929;2425.6967879015124;2450.4486490539666;2383.6662867198606;2393.365758074094;2398.304491697406;2407.9398015049587;2417.613181890889;9284.164425201765;9337.159655630958;9391.577379017961;9397.201237894787;9492.335536512446;5689.459501347406;5808.767649294065;5825.038868586678;5826.446487583673;5859.648421094748;3484.372812893678;3491.109767009422;3705.7776533407814;3728.571214310362;3754.099016236111;1120.9551617935272;1137.8975892169744;1149.4654985431814;1162.4187906046977;1178.599276246072;13761.724765504734;13781.655458613615;13848.792268115987;13919.930400348036;13926.51257206003;4891.119598472238;5004.124278251292;5013.874653133701;5060.240963855451;5087.974560127176;11494.712632184095;11550.653480395602;11550.826737598944;11558.248713833575;11596.884031159749;5745.85635359111;5759.424057594291;5771.797987070517;5827.271591051119;5839.240898683144;4708.835190768306;5123.97438012815;5300.92048619271;5307.310049693515;5372.489613486712;4318.265894797892;4329.307310830252;4345.869623911288;4354.150940566559;4421.38100665907;1338.6854089289009;1342.9189502450427;1353.262471952788;1357.932103394846;1363.1275983370651;916.5737931861717;1059.105056227502;1064.084886997182;1067.0876400677464;1071.1109778883663;6377;6474.773382931669;6520.673966301666;6564.934350656432;6582.275949645536;478.9976050119727;479.29304276193034;480.1573238965593;499.47804544251346;501.40583408660854;4198.391233271159;4239.173361194599;4318.395424640553;4332.285172946492;4369.235383807884;11801.232919860182;12065.638030859089;12129.33288669114;12156;12177.573784917486;11682.773308802623;11898;12031.819522707166;12034.879651203551;12057.939710301567;8514.403991720645;8815.471071735588;8826.426282291759;8881.42270752399;9075.682351117812;6637.568558043905;6657.500687448558;6719.697613607497;6764.053032575345;6799.762008329685;10577.471126443801;10790.136789057013;10868;10966.067884229611;10969;11451.25566838153;11495.712607184887;11563.132765042486;11637.709057273636;11643.941780291383;7617.733379331697;8204.83590328178;8299.6680132794;8547.914520854712;8630.870536942077;9355.06449355059;9363.344565880596;9379.437233765995;9388.906110938804;9396.95301523488;8332.875006874781;8492.065872753868;8543.91456085456;8631.43895646781;8677.956610216908;8207.753767386988;8249.381296402673;8284.83430331402;8316.459430137022;8350.457220280663;7255;7482.503499300271;7488.850222995618;7539.849203016019;7552.584607846621;5378.139497680509;5454.236406903116;5516.779328826802;5627.268455100811;5736.913946290892;5446.373667028342;5552.611317207757;5553.611247212818;5659.094544872801;5699.51554117888 15:13:03 INFO - PROCESS | 28363 | |4;prototype.html;333.9966600333996;342.35700392966305;344.51423492875045;349.58748676561646;351.7818952249606;5484.451554844513;5588.86027849303;5607.7756889724415;5646.350669672989;5697.715114244292;5575.526080283181;5591.888162236763;5602.215689803421;5637.830865074044;5644.322681278252;4340.131973605284;4351.586599273064;4368.694191406603;4388.956110438902;4398.274284743014;4138.834446622147;4331.566843315674;4359.912801743963;4363.759993200372;4383.605475507204;4277.395976508809;4278;4298.517011630998;4299.785010749466;4321.481422229337;4311.267084595611;4329.935050974238;4332.415123958257;4351.673624478177;4358.4987726411555;3682.815859207029;3766.642168993941;3841.0973421245985;3847.61523847613;3850.191459793447;5323.494268044529;5337.893242135136;5344;5383.008286933859;5387.946120538783;4947.381577302837;4948.628852836052;4957.182064959277;4962.751862406865;4966.180580204262;5550.250716153349;5828.300603927556;5837.824865254049;5859.970700146472;5895.64626122434;4163.958360416387;4189.72766770162;4190.308599081148;4193.329067349209;4197.433346498215;6108.786192483241;6127.5404344674325;6132.172156758825;6133.202683651186;6135.846603834895;4140.896477588024;4227.8097485613225;4261.573842615714;4262.3180291153885;4268.87193384199;4288.506821715543;4304.763238021939;4309.224339618899;4336.371226172188;4344.45694288214;4883.240968852587;4909;4959.156943319645;4987.750612469362;4997.675151115166;5795.652260864277;5873.20711703923;5914.704264786744;5916.668749531321;5922.378150294157;1483.990886197396;1487.4199062365685;1492.2091291615461;1498.7002599480147;1498.707751988352;915.8305713443034;922.8925289652444;942.7030485397078;946.9573869175904;947.5877993073035;5011.373578302712;5013.172826483662;5046.369203849519;5047.621428392885;5078.619103567247;5192.221166825007;5260.947390526046;5296.364436267596;5320.467953204648;5413.566914646819;4839.104765618372;4974.602031837444;4987.850364489072;5009.395114540492;5083.7203953782155;2847;2875.9502781484607;2877.5395936650034;2883.659098519199;2887.725666061721;5461.563074953994;5465.431247313756;5492.105223697818;5493.945060549423;5550.888982220333;5399.946000539944;5653.632513886584;6158.507319414436;6163.8150855474405;6208.192934918432;6311.589746666452;6315.210598675166;6318.684065796691;6340.714667839959;6355.586886852339;5962.373950735284;6138.938610613836;6139.723712432862;6151.169592105009;6159.876802464015;5973.761049558143;6009.338972712911;6025.758969641341;6060.2424696912885;6106.542009349406;5691.288588926384;6311.2426508819235;6315.147455093504;6350.237971443456;6352.968235158794;4277.695302932635;4283.914321713611;4296.656267498655;4304.5464085470985;4310.267254566668;6131.547381047617;6136.478399335928;6137.539684523768;6142.3550527194;6168.8766224674355;5697.4302569742695;5954.46409823118;5984.803039392226;5988.910166347596;6001.5798894077;5888.587798854211;5954.821355359346;5957.872117138364;6014.518838492998;6021;5825.038868586806;5838.32859221178;5843.276233511209;5856.238688970577;5879.176915231957;5662.57530685192;5995.310539288038;5995.850103747267;6049.667268300285;6071.180390647206;5824.922389357982;5885.293764748258;5899.764009439575;5905.43898329658;5911.940880591311 15:13:03 INFO - PROCESS | 28363 | |5;yui.html;784.533202744367;823.1110400767171;846.382141037043;854.9059603443616;875.6016012714216;13199.604011879646;13935.721285574307;13972.301384930764;14086.154830710151;14118.22349770761;12400.627981160556;13810.516631917884;13887;13924.651883702913;13935.860641393609;819.512390127873;839.3327304792705;841.032812265893;842.5702891525304;843.2705709561216;835.5613303015905;835.6866175184306;838.5974732128582;838.9748307550752;841.5035129273728;873.4453621950075;881.1628952495123;883.0639522106587;889.937704360695;891.1133422244875;874.7725591346232;875.9693410730594;878.2622597018535;878.8242351529656;882.4176043811086;639.0637715746453;639.6673729660597;641.6470940982441;641.6599202422677;641.6759536434117;14122.15267083968;14179.936504762185;14206.502772403019;14445.205513696743;14507.854921450757;13723.45106195751;13838;14088.295585220698;14522.201278929655;14573;11655.650330490098;11765.764684706259;11779.352135632536;11811.645650630495;11850.585229516926;3943.132510847609;3959.6238357356006;4051.554329023805;4131.9173616527505;4138.6482149017365;60240;60318.095228571605;60371.69814150901;61139.69430152865;61322.693386533225;11063.446827658585;11154.832677509843;11184.720381990353;11202.943985280184;11247.100231981585;19805.504862378268;19812.90093549552;19892.70160947587;19929.900350498443;19939.501512462306;8540.145985401534;8626.094260102724;8645.221930026202;8656.09111043344;8692.217700406994;4854.126257273654;4915.508449155127;4915.655904086751;4952.306677065214;4959.454460009396;3468.8092154931214;3577.982110089433;3595.748297619194;3599.9280014399565;3608.675219230282;635.2218532297898;637.6684124255454;656.9343065693488;672.5695554844904;672.8048865828953;764.1746913333586;769.5036701327613;780.6174974262684;817.8364327134597;824.4888169335051;10039.799204016024;10177.592896284066;10266.230032747573;10442.2168337375;10738.516766745515;734.7501849371239;759.1687102622619;790.1782146567621;800.5036877136213;827.5903427803156;4814.638902082358;4839.879003024882;4868.513148685103;4870.147724148331;4917.434495033045;68052;68695.62608747897;69335.65332173307;69756.30243697498;70167.2983270171;62430.37569624336;62432.68783656143;62775;63740.36259637437;64358.356416435236;57397.26917750333;57745.13382299269;58212;58675.41324586785;59148.11277830836;9002;9076.636934522545;9140.954295228481;9149.268058555434;9242.306826987868;36722.26555468929;36906.63093369032;37219.441708374936;37316.440253396766;37580;44148.55851441444;48972;49300.26049609187;50527.74736126296;50683.74658126686;11969.940150299193;12000.219985700902;12064.638060858188;12236.69408264765;12337.321447320484;12846;13323.86676133265;13350.332483375598;13396;13445.462181513021;12588.811167832673;12728.936355318165;12779.297138657463;13074.477020919057;13171.868281317447;12279.386030698608;12507.874921250672;12574.164775216155;12626.494940202288;12685.175463594836;12203;12575;12599.307038112991;12793.42429590652;14184.645383865485;11521.82717259225;11740.70648233801;12065.638030859089;12205.389730513616;12223.69440763988;11907.404629768303;11944.76110477803;12116;12117.454714538044;12210.57262995791 15:13:03 INFO - PROCESS | 28363 | __end_tp_report 15:13:03 INFO - PROCESS | 28363 | __start_cc_report 15:13:03 INFO - PROCESS | 28363 | _x_x_mozilla_cycle_collect,343 15:13:03 INFO - PROCESS | 28363 | __end_cc_report 15:13:03 INFO - PROCESS | 28363 | __startTimestamp1463177583345__endTimestamp 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | ------- Summary: start ------- 15:13:03 INFO - PROCESS | 28363 | Number of tests: 6 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#0] dojo.html Cycles:165 Average:5564.45 Median:5840.00 stddev:741.99 (12.7%) stddev-sans-first:720.91 15:13:03 INFO - PROCESS | 28363 | Values: 3210.1 3246.7 3256.1 3273.0 3287.9 5538.7 5571.8 5637.5 5687.1 5699.8 5443.0 5596.6 5619.0 5625.6 5639.4 5026.3 5062.0 5155.6 5178.2 5188.8 922.6 5091.6 5103.2 5135.0 5148.3 5041.6 5068.5 5089.7 5100.8 5103.9 5042.1 5077.9 5098.4 5099.4 5102.1 5056.2 5107.6 5143.8 5143.9 5147.9 5592.1 5609.3 5625.9 5654.8 5691.1 5802.4 5880.2 5962.0 6120.3 6141.0 6000.6 6006.8 6037.5 6061.3 6102.8 5570.4 5610.1 5642.5 5646.9 5647.4 6024.5 6091.5 6106.4 6108.4 6153.7 5910.0 5959.5 5963.3 5964.9 5970.3 6036.6 6047.4 6068.4 6077.6 6087.6 5838.9 5949.4 6008.1 6010.1 6023.8 5872.7 5881.0 5907.0 5969.2 6025.6 4522.8 4529.7 4538.2 4548.0 4590.6 3971.5 4017.2 4021.6 4024.5 4028.1 5775.6 5815.4 5840.0 5842.0 5901.3 6080.5 6098.7 6134.2 6152.7 6165.2 5583.4 5703.2 5781.0 5824.8 5841.9 5161.7 5177.2 5186.1 5189.9 5199.5 6249.6 6260.7 6294.5 6294.7 6301.6 5932.4 5949.9 5979.1 6019.2 6035.1 6139.9 6149.4 6182.2 6220.4 6222.2 5773.0 5930.3 5935.5 5935.8 5940.7 6001.6 6011.4 6059.5 6062.4 6078.0 5858.3 5916.8 5923.6 5940.3 5961.0 5831.4 5879.9 5901.6 5931.5 5941.6 5536.9 5795.6 5815.2 5895.9 5935.4 5893.4 5923.6 5941.3 5943.5 5968.2 5649.0 5825.7 5829.0 5829.6 5831.6 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#1] ext.html Cycles:180 Average:64410.16 Median:43484.57 stddev:133834.28 (307.8%) stddev-sans-first:134123.95 15:13:03 INFO - PROCESS | 28363 | Values: 592.2 624.2 647.0 647.9 667.3 43472.1 44064.8 44117.0 44277.1 48636.5 45871.5 46453.8 46555.8 46616.3 46730.8 8971.5 9096.5 9115.3 9115.6 9131.0 8902.6 9024.1 9052.2 9061.5 9071.5 9099.8 9100.3 9106.5 9109.7 9127.5 9009.2 9097.7 9112.0 9131.0 9150.1 8742.3 8904.7 8918.8 8937.2 8948.3 43601.8 44062.0 44096.8 44123.1 44134.6 3705.7 4208.8 4247.1 4291.4 4494.1 33289.3 33491.3 33865.5 33894.8 34697.7 4421.6 4519.3 4519.5 4600.4 4671.6 383684.0 385750.0 386650.0 387511.0 387603.0 36436.5 37404.8 37457.8 64103.7 65925.0 38590.2 38780.6 38785.0 38973.0 38998.2 15924.9 16093.8 16115.4 16130.7 16146.8 13546.4 13711.6 13717.0 13770.8 13794.4 8756.7 8767.4 8783.1 8821.2 8863.3 3375.0 3376.3 3383.9 3407.9 3448.0 1087.6 1102.9 1130.4 1163.2 1211.9 33710.5 33979.5 34038.3 34118.3 34225.1 1162.6 1183.8 1210.0 1255.5 1262.6 17936.3 18021.5 18078.9 18132.4 18153.3 612757.0 620786.0 621016.0 621159.0 623056.0 62839.7 63405.7 63808.7 63852.0 63903.4 1430.3 1430.4 1461.4 1461.8 1462.4 30854.2 31660.4 31664.0 31787.5 32241.0 55157.4 55485.0 55556.0 55593.7 55704.4 465172.0 474303.0 474778.0 475148.0 475911.0 29444.1 29453.3 29529.7 29621.6 29872.0 50805.7 51834.0 52155.0 52394.7 52540.5 41590.0 43101.0 43495.6 44160.6 44279.6 42053.6 42191.2 42350.2 43248.8 43505.3 43325.0 43473.6 44106.0 44463.8 47090.8 37770.4 37830.2 37961.0 38250.4 38519.6 29856.3 29957.6 30328.4 30329.0 30395.0 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#2] jquery.html Cycles:180 Average:29456.58 Median:2056.74 stddev:82883.87 (4029.9%) stddev-sans-first:83087.65 15:13:03 INFO - PROCESS | 28363 | Values: 388.7 389.9 389.9 394.9 405.5 17903.9 19413.9 19503.8 19612.4 20247.0 19060.9 19311.6 19613.5 19802.3 19903.5 5567.4 5608.7 5822.0 5872.3 5883.4 5748.5 5795.5 5799.7 5800.4 5824.9 5794.6 6270.7 6411.7 6421.8 6459.4 5849.9 6289.8 6390.1 6390.9 6413.7 5520.8 5599.6 5604.2 5638.5 5655.0 13632.7 15347.4 22100.2 22287.6 22394.9 2378.7 2418.7 2441.4 2520.4 2906.1 10182.2 10545.1 10996.1 14106.1 14439.5 1966.5 1984.7 1990.1 2054.0 2059.5 82381.6 85552.1 85743.6 86138.6 87228.6 10890.9 11018.4 11033.1 11162.3 11273.8 15470.1 15580.3 15591.5 15612.9 15635.2 8260.6 8469.5 8477.1 8500.1 8533.5 8146.7 8170.5 8246.0 8269.3 8460.2 4609.8 4687.6 4695.6 4727.4 4750.2 1954.8 1967.4 1987.1 2025.9 2032.1 1004.4 1017.1 1022.6 1064.6 1149.4 19022.1 19139.5 19298.3 19590.8 19885.4 1038.6 1043.0 1051.5 1064.1 1085.5 10567.5 10759.5 10956.9 10968.9 11004.7 490068.0 496031.0 496802.0 511115.0 516560.0 95567.0 96047.0 96895.5 97066.0 97344.0 1047.0 1060.6 1069.6 1082.6 1083.8 16815.2 16937.6 17022.2 17047.5 17335.3 29119.0 39600.4 39845.2 40995.0 41997.8 52604.7 54038.0 58323.0 58582.0 58780.7 8545.6 8582.1 8694.0 8707.5 8980.0 11990.6 12498.0 12791.6 12824.7 13150.5 11442.2 11532.5 11634.3 11707.5 11985.6 11536.5 11541.2 11602.8 11990.3 12087.6 11973.8 12115.8 12116.8 12206.1 12225.4 8207.7 8349.0 8383.5 8402.5 8405.0 10350.2 11204.6 11221.2 11337.2 11431.8 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#3] mootools.html Cycles:180 Average:6288.87 Median:479.15 stddev:3668.86 (765.7%) stddev-sans-first:3661.78 15:13:03 INFO - PROCESS | 28363 | Values: 1537.1 1578.7 1773.8 1862.7 1877.1 8373.2 9015.2 9408.2 9600.9 9659.8 8915.9 8962.6 8984.4 9074.6 9085.9 2452.8 2480.2 2484.0 2486.5 2493.6 2424.8 2434.3 2439.3 2457.8 2461.1 2377.5 2392.5 2408.5 2411.4 2412.8 2362.2 2386.5 2389.5 2425.7 2450.4 2383.7 2393.4 2398.3 2407.9 2417.6 9284.2 9337.2 9391.6 9397.2 9492.3 5689.5 5808.8 5825.0 5826.4 5859.6 3484.4 3491.1 3705.8 3728.6 3754.1 1121.0 1137.9 1149.5 1162.4 1178.6 13761.7 13781.7 13848.8 13919.9 13926.5 4891.1 5004.1 5013.9 5060.2 5088.0 11494.7 11550.7 11550.8 11558.2 11596.9 5745.9 5759.4 5771.8 5827.3 5839.2 4708.8 5124.0 5300.9 5307.3 5372.5 4318.3 4329.3 4345.9 4354.2 4421.4 1338.7 1342.9 1353.3 1357.9 1363.1 916.6 1059.1 1064.1 1067.1 1071.1 6377.0 6474.8 6520.7 6564.9 6582.3 479.0 479.3 480.2 499.5 501.4 4198.4 4239.2 4318.4 4332.3 4369.2 11801.2 12065.6 12129.3 12156.0 12177.6 11682.8 11898.0 12031.8 12034.9 12057.9 8514.4 8815.5 8826.4 8881.4 9075.7 6637.6 6657.5 6719.7 6764.1 6799.8 10577.5 10790.1 10868.0 10966.1 10969.0 11451.3 11495.7 11563.1 11637.7 11643.9 7617.7 8204.8 8299.7 8547.9 8630.9 9355.1 9363.3 9379.4 9388.9 9397.0 8332.9 8492.1 8543.9 8631.4 8678.0 8207.8 8249.4 8284.8 8316.5 8350.5 7255.0 7482.5 7488.9 7539.8 7552.6 5378.1 5454.2 5516.8 5627.3 5736.9 5446.4 5552.6 5553.6 5659.1 5699.5 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#4] prototype.html Cycles:180 Average:4866.66 Median:5437.56 stddev:1455.89 (26.8%) stddev-sans-first:1419.67 15:13:03 INFO - PROCESS | 28363 | Values: 334.0 342.4 344.5 349.6 351.8 5484.5 5588.9 5607.8 5646.4 5697.7 5575.5 5591.9 5602.2 5637.8 5644.3 4340.1 4351.6 4368.7 4389.0 4398.3 4138.8 4331.6 4359.9 4363.8 4383.6 4277.4 4278.0 4298.5 4299.8 4321.5 4311.3 4329.9 4332.4 4351.7 4358.5 3682.8 3766.6 3841.1 3847.6 3850.2 5323.5 5337.9 5344.0 5383.0 5387.9 4947.4 4948.6 4957.2 4962.8 4966.2 5550.3 5828.3 5837.8 5860.0 5895.6 4164.0 4189.7 4190.3 4193.3 4197.4 6108.8 6127.5 6132.2 6133.2 6135.8 4140.9 4227.8 4261.6 4262.3 4268.9 4288.5 4304.8 4309.2 4336.4 4344.5 4883.2 4909.0 4959.2 4987.8 4997.7 5795.7 5873.2 5914.7 5916.7 5922.4 1484.0 1487.4 1492.2 1498.7 1498.7 915.8 922.9 942.7 947.0 947.6 5011.4 5013.2 5046.4 5047.6 5078.6 5192.2 5260.9 5296.4 5320.5 5413.6 4839.1 4974.6 4987.9 5009.4 5083.7 2847.0 2876.0 2877.5 2883.7 2887.7 5461.6 5465.4 5492.1 5493.9 5550.9 5399.9 5653.6 6158.5 6163.8 6208.2 6311.6 6315.2 6318.7 6340.7 6355.6 5962.4 6138.9 6139.7 6151.2 6159.9 5973.8 6009.3 6025.8 6060.2 6106.5 5691.3 6311.2 6315.1 6350.2 6353.0 4277.7 4283.9 4296.7 4304.5 4310.3 6131.5 6136.5 6137.5 6142.4 6168.9 5697.4 5954.5 5984.8 5988.9 6001.6 5888.6 5954.8 5957.9 6014.5 6021.0 5825.0 5838.3 5843.3 5856.2 5879.2 5662.6 5995.3 5995.9 6049.7 6071.2 5824.9 5885.3 5899.8 5905.4 5911.9 15:13:03 INFO - PROCESS | 28363 | 15:13:03 INFO - PROCESS | 28363 | [#5] yui.html Cycles:180 Average:16004.43 Median:24481.60 stddev:19259.00 (78.7%) stddev-sans-first:19279.12 15:13:03 INFO - PROCESS | 28363 | Values: 784.5 823.1 846.4 854.9 875.6 13199.6 13935.7 13972.3 14086.2 14118.2 12400.6 13810.5 13887.0 13924.7 13935.9 819.5 839.3 841.0 842.6 843.3 835.6 835.7 838.6 839.0 841.5 873.4 881.2 883.1 889.9 891.1 874.8 876.0 878.3 878.8 882.4 639.1 639.7 641.6 641.7 641.7 14122.2 14179.9 14206.5 14445.2 14507.9 13723.5 13838.0 14088.3 14522.2 14573.0 11655.7 11765.8 11779.4 11811.6 11850.6 3943.1 3959.6 4051.6 4131.9 4138.6 60240.0 60318.1 60371.7 61139.7 61322.7 11063.4 11154.8 11184.7 11202.9 11247.1 19805.5 19812.9 19892.7 19929.9 19939.5 8540.1 8626.1 8645.2 8656.1 8692.2 4854.1 4915.5 4915.7 4952.3 4959.5 3468.8 3578.0 3595.7 3599.9 3608.7 635.2 637.7 656.9 672.6 672.8 764.2 769.5 780.6 817.8 824.5 10039.8 10177.6 10266.2 10442.2 10738.5 734.8 759.2 790.2 800.5 827.6 4814.6 4839.9 4868.5 4870.1 4917.4 68052.0 68695.6 69335.7 69756.3 70167.3 62430.4 62432.7 62775.0 63740.4 64358.4 57397.3 57745.1 58212.0 58675.4 59148.1 9002.0 9076.6 9141.0 9149.3 9242.3 36722.3 36906.6 37219.4 37316.4 37580.0 44148.6 48972.0 49300.3 50527.7 50683.7 11969.9 12000.2 12064.6 12236.7 12337.3 12846.0 13323.9 13350.3 13396.0 13445.5 12588.8 12728.9 12779.3 13074.5 13171.9 12279.4 12507.9 12574.2 12626.5 12685.2 12203.0 12575.0 12599.3 12793.4 14184.6 11521.8 11740.7 12065.6 12205.4 12223.7 11907.4 11944.8 12116.0 12117.5 12210.6 15:13:03 INFO - PROCESS | 28363 | -------- Summary: end -------- 15:13:03 INFO - PROCESS | 28363 | 15:13:04 INFO - TEST-INFO | 28363: exit 0 15:13:04 INFO - TEST-OK | dromaeo_css | took 1109854ms 15:13:04 INFO - TEST-START | kraken 15:13:04 INFO - operating with platform_type : linux_ 15:13:04 INFO - Initialising browser for kraken test... 15:13:04 INFO - TEST-INFO | started process 28594 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphSDcqa/profile http://localhost:46265/getInfo.html) 15:13:07 INFO - PROCESS | 28594 | 15:13:07 INFO - PROCESS | 28594 | (process:28662): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:08 INFO - PROCESS | 28594 | __metrics Screen width/height:1600/1200 15:13:08 INFO - PROCESS | 28594 | colorDepth:24 15:13:08 INFO - PROCESS | 28594 | Browser inner width/height: 1024/697 15:13:08 INFO - PROCESS | 28594 | __metrics 15:13:09 ERROR - PROCESS | 28594 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2946: TypeError: this.tabs is undefined 15:13:09 INFO - TEST-INFO | 28594: exit 0 15:13:09 INFO - Browser initialized. 15:13:09 INFO - Running cycle 1/1 for kraken test... 15:13:09 INFO - TEST-INFO | started process 28713 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphSDcqa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:13:11 INFO - PROCESS | 28713 | 15:13:11 INFO - PROCESS | 28713 | (process:28774): GLib-CRITICAL **: g_path_get_basename: assertion `file_name != NULL' failed 15:13:21 INFO - PROCESS | 28713 | RSS: Main: 163909632 15:13:21 INFO - PROCESS | 28713 | 15:13:24 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46265/tests/kraken/driver.html?testName=audio-beat-detection) 15:13:25 INFO - PROCESS | 28713 | RSS: Main: 168189952 15:13:25 INFO - PROCESS | 28713 | 15:13:28 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46265/tests/kraken/driver.html?testName=audio-dft) 15:13:28 INFO - PROCESS | 28713 | RSS: Main: 168222720 15:13:28 INFO - PROCESS | 28713 | 15:13:31 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46265/tests/kraken/driver.html?testName=audio-fft) 15:13:32 INFO - PROCESS | 28713 | RSS: Main: 163835904 15:13:32 INFO - PROCESS | 28713 | 15:13:34 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46265/tests/kraken/driver.html?testName=audio-oscillator) 15:13:35 INFO - PROCESS | 28713 | RSS: Main: 163897344 15:13:35 INFO - PROCESS | 28713 | 15:13:37 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46265/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:13:37 INFO - PROCESS | 28713 | RSS: Main: 164225024 15:13:37 INFO - PROCESS | 28713 | 15:13:41 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46265/tests/kraken/driver.html?testName=imaging-darkroom) 15:13:41 INFO - PROCESS | 28713 | RSS: Main: 164077568 15:13:41 INFO - PROCESS | 28713 | 15:13:45 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46265/tests/kraken/driver.html?testName=imaging-desaturate) 15:13:45 INFO - PROCESS | 28713 | RSS: Main: 163237888 15:13:45 INFO - PROCESS | 28713 | 15:13:48 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46265/tests/kraken/driver.html?testName=json-parse-financial) 15:13:49 INFO - PROCESS | 28713 | RSS: Main: 163516416 15:13:49 INFO - PROCESS | 28713 | 15:13:51 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46265/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:13:51 INFO - PROCESS | 28713 | RSS: Main: 163667968 15:13:51 INFO - PROCESS | 28713 | 15:13:53 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:13:54 INFO - PROCESS | 28713 | RSS: Main: 163880960 15:13:54 INFO - PROCESS | 28713 | 15:13:56 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:13:57 INFO - PROCESS | 28713 | RSS: Main: 163815424 15:13:57 INFO - PROCESS | 28713 | 15:13:59 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:14:00 INFO - PROCESS | 28713 | RSS: Main: 164020224 15:14:00 INFO - PROCESS | 28713 | 15:14:03 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:14:03 INFO - PROCESS | 28713 | RSS: Main: 164331520 15:14:03 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | Cycle 1(1): loaded http://localhost:46265/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46265/tests/kraken/driver.html?testName=ai-astar) 15:14:05 INFO - PROCESS | 28713 | RSS: Main: 165527552 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | __start_tp_report 15:14:05 INFO - PROCESS | 28713 | _x_x_mozilla_page_load 15:14:05 INFO - PROCESS | 28713 | _x_x_mozilla_page_load_details 15:14:05 INFO - PROCESS | 28713 | |i|pagename|runs| 15:14:05 INFO - PROCESS | 28713 | |0;ai-astar;110;114;104;109;111;111;105;108;109;111 15:14:05 INFO - PROCESS | 28713 | |1;audio-beat-detection;158;126;152;218;125;160;154;127;175;124 15:14:05 INFO - PROCESS | 28713 | |2;audio-dft;164;162;162;162;164;178;163;163;162;161 15:14:05 INFO - PROCESS | 28713 | |3;audio-fft;75;76;75;168;76;75;74;75;165;76 15:14:05 INFO - PROCESS | 28713 | |4;audio-oscillator;92;90;170;91;91;91;149;93;91;146 15:14:05 INFO - PROCESS | 28713 | |5;imaging-gaussian-blur;118;118;118;117;122;120;121;121;121;121 15:14:05 INFO - PROCESS | 28713 | |6;imaging-darkroom;146;147;148;146;146;148;148;146;148;147 15:14:05 INFO - PROCESS | 28713 | |7;imaging-desaturate;95;96;96;96;97;95;95;96;96;95 15:14:05 INFO - PROCESS | 28713 | |8;json-parse-financial;55;56;55;54;57;57;55;111;55;56 15:14:05 INFO - PROCESS | 28713 | |9;json-stringify-tinderbox;58;58;58;59;60;59;58;58;58;58 15:14:05 INFO - PROCESS | 28713 | |10;stanford-crypto-aes;79;83;80;83;79;83;82;82;83;78 15:14:05 INFO - PROCESS | 28713 | |11;stanford-crypto-ccm;126;128;132;129;122;121;120;141;197;123 15:14:05 INFO - PROCESS | 28713 | |12;stanford-crypto-pbkdf2;166;162;166;163;167;156;166;157;163;164 15:14:05 INFO - PROCESS | 28713 | |13;stanford-crypto-sha256-iterative;68;64;66;64;63;63;63;63;61;63 15:14:05 INFO - PROCESS | 28713 | __end_tp_report 15:14:05 INFO - PROCESS | 28713 | __start_cc_report 15:14:05 INFO - PROCESS | 28713 | _x_x_mozilla_cycle_collect,857 15:14:05 INFO - PROCESS | 28713 | __end_cc_report 15:14:05 INFO - PROCESS | 28713 | __startTimestamp1463177645689__endTimestamp 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | ------- Summary: start ------- 15:14:05 INFO - PROCESS | 28713 | Number of tests: 14 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#0] ai-astar Cycles:10 Average:109.20 Median:110.50 stddev:2.97 (2.7%) stddev-sans-first:3.14 15:14:05 INFO - PROCESS | 28713 | Values: 110.0 114.0 104.0 109.0 111.0 111.0 105.0 108.0 109.0 111.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#1] audio-beat-detection Cycles:10 Average:151.90 Median:156.00 stddev:29.44 (18.9%) stddev-sans-first:31.15 15:14:05 INFO - PROCESS | 28713 | Values: 158.0 126.0 152.0 218.0 125.0 160.0 154.0 127.0 175.0 124.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.00 stddev:4.98 (3.1%) stddev-sans-first:5.28 15:14:05 INFO - PROCESS | 28713 | Values: 164.0 162.0 162.0 162.0 164.0 178.0 163.0 163.0 162.0 161.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#3] audio-fft Cycles:10 Average:93.50 Median:75.00 stddev:38.49 (51.3%) stddev-sans-first:40.23 15:14:05 INFO - PROCESS | 28713 | Values: 75.0 76.0 75.0 168.0 76.0 75.0 74.0 75.0 165.0 76.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#4] audio-oscillator Cycles:10 Average:110.40 Median:91.00 stddev:31.40 (34.5%) stddev-sans-first:32.59 15:14:05 INFO - PROCESS | 28713 | Values: 92.0 90.0 170.0 91.0 91.0 91.0 149.0 93.0 91.0 146.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#5] imaging-gaussian-blur Cycles:10 Average:119.70 Median:121.00 stddev:1.77 (1.5%) stddev-sans-first:1.76 15:14:05 INFO - PROCESS | 28713 | Values: 118.0 118.0 118.0 117.0 122.0 120.0 121.0 121.0 121.0 121.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 15:14:05 INFO - PROCESS | 28713 | Values: 146.0 147.0 148.0 146.0 146.0 148.0 148.0 146.0 148.0 147.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.67 15:14:05 INFO - PROCESS | 28713 | Values: 95.0 96.0 96.0 96.0 97.0 95.0 95.0 96.0 96.0 95.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:55.50 stddev:17.56 (31.6%) stddev-sans-first:18.48 15:14:05 INFO - PROCESS | 28713 | Values: 55.0 56.0 55.0 54.0 57.0 57.0 55.0 111.0 55.0 56.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#9] json-stringify-tinderbox Cycles:10 Average:58.40 Median:58.00 stddev:0.70 (1.2%) stddev-sans-first:0.73 15:14:05 INFO - PROCESS | 28713 | Values: 58.0 58.0 58.0 59.0 60.0 59.0 58.0 58.0 58.0 58.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.50 stddev:1.99 (2.4%) stddev-sans-first:1.94 15:14:05 INFO - PROCESS | 28713 | Values: 79.0 83.0 80.0 83.0 79.0 83.0 82.0 82.0 83.0 78.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:128.50 stddev:23.04 (17.9%) stddev-sans-first:24.26 15:14:05 INFO - PROCESS | 28713 | Values: 126.0 128.0 132.0 129.0 122.0 121.0 120.0 141.0 197.0 123.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.00 Median:165.00 stddev:3.80 (2.3%) stddev-sans-first:3.87 15:14:05 INFO - PROCESS | 28713 | Values: 166.0 162.0 166.0 163.0 167.0 156.0 166.0 157.0 163.0 164.0 15:14:05 INFO - PROCESS | 28713 | 15:14:05 INFO - PROCESS | 28713 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:63.50 stddev:1.93 (3.0%) stddev-sans-first:1.32 15:14:05 INFO - PROCESS | 28713 | Values: 68.0 64.0 66.0 64.0 63.0 63.0 63.0 63.0 61.0 63.0 15:14:05 INFO - PROCESS | 28713 | -------- Summary: end -------- 15:14:05 INFO - PROCESS | 28713 | 15:14:06 INFO - TEST-INFO | 28713: exit 0 15:14:06 INFO - TEST-OK | kraken | took 62457ms 15:14:06 INFO - SUITE-END | took 1172s 15:14:06 INFO - Completed test suite (00:19:32) 15:14:06 INFO - javascript benchmark 15:14:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7353.244054587929, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.117217765114, 3246.7077962983326, 3256.0720194744504, 3272.967270327297, 3287.934241315174, 5538.695371754557, 5571.8328450146455, 5637.520810731087, 5687.118496633018, 5699.829005129853, 5443.047466693332, 5596.636218645795, 5618.971905140479, 5625.634333768302, 5639.379668236491, 5026.3214466047075, 5062.0, 5155.561777248939, 5178.197379406198, 5188.796825301864, 922.6421496400068, 5091.592672586185, 5103.183490641498, 5135.024345374367, 5148.279240906276, 5041.571466425358, 5068.493150684939, 5089.694618322913, 5100.795968161269, 5103.9489605103845, 5042.117629414838, 5077.923831142536, 5098.388193416777, 5099.36257967754, 5102.107131252016, 5056.216286475602, 5107.591392688613, 5143.8456846294675, 5143.922841157386, 5147.871303217412, 5592.105263157916, 5609.3268807742925, 5625.8593535161945, 5654.773809047633, 5691.06097493913, 5802.419758024206, 5880.176775251468, 5962.046072628402, 6120.296165940885, 6141.0, 6000.6399616022745, 6006.819795406145, 6037.45662890342, 6061.272647282311, 6102.755889764404, 5570.41510641385, 5610.074337734269, 5642.548596112342, 5646.915296270559, 5647.407022262685, 6024.548158888101, 6091.543134264948, 6106.358832322631, 6108.419700128481, 6153.661548614869, 5910.0, 5959.4934430573885, 5963.254593175853, 5964.880702385928, 5970.253718285215, 6036.577439579275, 6047.395260473917, 6068.393160683896, 6077.604955677867, 6087.604305720114, 5838.883222335529, 5949.434803693643, 6008.09878518217, 6010.128531362928, 6023.759049638053, 5872.706364681749, 5881.0, 5906.970465147732, 5969.194158788595, 6025.6083354581815, 4522.751248681288, 4529.705569137996, 4538.205813982539, 4547.954520454753, 4590.609798167126, 3971.523417189898, 4017.196560687874, 4021.6380525752825, 4024.4969378827645, 4028.093678922278, 5775.595708300462, 5815.389384114607, 5840.0, 5842.036064049385, 5901.291844978544, 6080.452759251689, 6098.72555734993, 6134.2332208473945, 6152.692365381713, 6165.167702360213, 5583.35791383996, 5703.201551782754, 5781.046127389018, 5824.796132135355, 5841.94158058414, 5161.716105614228, 5177.223416487557, 5186.092433824066, 5189.948100518946, 5199.506046925536, 6249.625022498573, 6260.718267677874, 6294.527910406646, 6294.748210071637, 6301.558890877686, 5932.436418540232, 5949.910751338647, 5979.133025711334, 6019.217501724747, 6035.094735789667, 6139.938600614116, 6149.442992437482, 6182.196314479089, 6220.409061139185, 6222.160008398808, 5772.9711351442975, 5930.34766175729, 5935.465808077293, 5935.821925342247, 5940.702964851654, 6001.639901605918, 6011.368806275453, 6059.545534084873, 6062.393760623902, 6078.02751559766, 5858.326292476419, 5916.822495325147, 5923.585349025527, 5940.316863560746, 5960.970195148997, 5831.416858314305, 5879.853003674943, 5901.557383196192, 5931.525477961839, 5941.643501389931, 5536.861578460571, 5795.594308398372, 5815.244018277597, 5895.882082358415, 5935.376785437467, 5893.381194974466, 5923.585349025527, 5941.346451890375, 5943.52451803846, 5968.224130863134, 5649.039663257338, 5825.70871456417, 5829.038208695687, 5829.562782791392, 5831.562632802642], "value": 5515.151768742503, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [592.2271435776313, 624.1573875268388, 646.9773557925473, 647.9384458476449, 667.3493343989611, 43472.13055738883, 44064.779676101614, 44116.999999999956, 44277.11445771083, 48636.513634863644, 45871.54128458723, 46453.76773116138, 46555.76722116393, 46616.30075548869, 46730.766346168224, 8971.50656713879, 9096.499692516942, 9115.27077833775, 9115.589798459052, 9131.041240669734, 8902.643894244222, 9024.052474490183, 9052.23056040234, 9061.50161741104, 9071.501067441288, 9099.818003639923, 9100.317476189279, 9106.453612783222, 9109.68116115936, 9127.497987610679, 9009.189172974431, 9097.727068187965, 9111.95444022779, 9131.0412406697, 9150.130737579986, 8742.30061595071, 8904.688335908211, 8918.821623567557, 8937.240334571568, 8948.328875334377, 43601.78199109016, 44062.0, 44096.779516102535, 44123.117537649065, 44134.55865441337, 3705.7035437164964, 4208.789560521992, 4247.10810729744, 4291.420658211133, 4494.1461122386645, 33289.33421331584, 33491.33017339664, 33865.492017619756, 33894.83052584746, 34697.653023469946, 4421.624161946238, 4519.344695019204, 4519.525449827786, 4600.401947746805, 4671.6262698984, 383684.0, 385750.0, 386650.0, 387511.0, 387603.0, 36436.45345319822, 37404.81297593495, 37457.812710936814, 64103.67948160323, 65925.0, 38590.228195436495, 38780.6121938777, 38785.0, 38973.0, 38998.22003559913, 15924.92037539805, 16093.839061609468, 16115.435959741353, 16130.67738645244, 16146.75779863303, 13546.390412431465, 13711.588652340446, 13717.0, 13770.793438098237, 13794.379252933642, 8756.693515727047, 8767.430117042371, 8783.121687831293, 8821.206091451671, 8863.290936725047, 3375.0, 3376.307856889332, 3383.9154021149175, 3407.914802129917, 3447.965610316895, 1087.581281206741, 1102.9172812039128, 1130.4065365683082, 1163.203205804027, 1211.9091068169746, 33710.49434258488, 33979.49030764541, 34038.31923361519, 34118.31763364719, 34225.14437139092, 1162.6221478019677, 1183.8401815754935, 1209.9758004839855, 1255.4727014653868, 1262.6338361874953, 17936.282548698167, 18021.459356219333, 18078.90960545189, 18132.365367212085, 18153.273869045355, 612757.0, 620786.0, 621016.0, 621159.0, 623056.0, 62839.6858015707, 63405.68297158484, 63808.68095659492, 63851.99999999907, 63903.36096639067, 1430.2920054572844, 1430.370636919752, 1461.3935216884875, 1461.751502244621, 1462.4077248714289, 30854.228644284074, 31660.366792664478, 31664.0, 31787.523187152674, 32241.012698475377, 55157.448425515235, 55485.0, 55556.0, 55593.72203138958, 55704.442955569924, 465172.0, 474303.0, 474778.0, 475148.0, 475911.0, 29444.11667649974, 29453.26366840846, 29529.704702952695, 29621.555676664437, 29872.0, 50805.745971269906, 51833.96332073262, 52155.0, 52394.73802630963, 52540.47459525509, 41590.0, 43101.0, 43495.565044349154, 44160.558394415646, 44279.557204428835, 42053.579464204966, 42191.1561768769, 42350.1529969405, 43248.783756081015, 43505.34741978936, 43325.0, 43473.56526434695, 44106.0, 44463.77768111139, 47090.76454617705, 37770.43344349782, 37830.24339513249, 37961.0, 38250.42624360581, 38519.614803851604, 29856.253593659465, 29957.550636740903, 30328.393432130793, 30329.0, 30395.0], "value": 19958.40710412468, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.7473142457404, 389.8752399232245, 389.94906290365833, 394.8696930013095, 405.45263893743453, 17903.910480447597, 19413.902930485347, 19503.804961950394, 19612.411627651156, 20247.0, 19060.904695476504, 19311.613767724637, 19613.50966225845, 19802.30691925783, 19903.50241243966, 5567.415421380758, 5608.747606357723, 5822.039363505017, 5872.265966754156, 5883.3528311885875, 5748.511376533, 5795.536357091422, 5799.73901174446, 5800.361960184377, 5824.883502329951, 5794.62334948227, 6270.717817698214, 6411.679416029203, 6421.839454013663, 6459.41865232129, 5849.912251316234, 6289.842753931189, 6390.137331460263, 6390.904136437957, 6413.743450262007, 5520.751566179531, 5599.636023658449, 5604.215409842625, 5638.4925356718095, 5655.0386434306265, 13632.727345453135, 15347.386104555915, 22100.2264920727, 22287.554248915094, 22394.88802555977, 2378.7383387827326, 2418.661387405765, 2441.3652450362856, 2520.3699075231193, 2906.099109276131, 10182.18542516597, 10545.050945414872, 10996.12031037515, 14106.083104598169, 14439.494617688331, 1966.469053355586, 1984.662607356753, 1990.0547240061, 2054.0, 2059.4851287178208, 82381.58809205976, 85552.14447855504, 85743.5712821432, 86138.56930715307, 87228.56385718031, 10890.891091089146, 11018.39398833072, 11033.117350611932, 11162.274452160584, 11273.774524509465, 15470.071795692069, 15580.298886550132, 15591.454299099478, 15612.921935390477, 15635.218239088, 8260.628271727786, 8469.491830490191, 8477.067522572512, 8500.14998500145, 8533.487990720576, 8146.714864979697, 8170.468919520212, 8245.95877020623, 8269.255766980881, 8460.153984601613, 4609.7695115244105, 4687.6249900007915, 4695.624350051988, 4727.361806156125, 4750.158781737893, 1954.7556555430572, 1967.3867428708609, 1987.125664707553, 2025.888576128327, 2032.1464984706458, 1004.3823048825066, 1017.0998666180336, 1022.5602990713916, 1064.595453727594, 1149.431031639327, 19022.144003519876, 19139.521511962033, 19298.32455864038, 19590.804091959184, 19885.403437896886, 1038.6364772329623, 1042.9634962776267, 1051.4690081508788, 1064.095518809006, 1085.5223701571442, 10567.471626418648, 10759.462026898624, 10956.945215273872, 10968.945155274172, 11004.724881878017, 490068.0, 496031.0, 496802.0, 511115.0, 516560.0, 95567.0, 96047.0, 96895.51552242193, 97066.0, 97344.0, 1047.0367262118868, 1060.5704689600725, 1069.5507886687453, 1082.588616325807, 1083.766990097133, 16815.243314051142, 16937.576560586083, 17022.2339994703, 17047.488575342264, 17335.306587736854, 29119.0, 39600.40599391069, 39845.2030959385, 40995.0, 41997.79001104975, 52604.736976314874, 54038.0, 58323.0, 58582.0, 58780.70609646924, 8545.572721363782, 8582.141785821368, 8694.0, 8707.521086340312, 8980.012198658012, 11990.640280791591, 12498.000159986997, 12791.552295669608, 12824.743505129658, 13150.473981041034, 11442.199046066695, 11532.538698452303, 11634.301941883514, 11707.473163707824, 11985.580504682643, 11536.538538458703, 11541.192116551762, 11602.76794464123, 11990.280583165038, 12087.637370878887, 11973.76052478963, 12115.81826272589, 12116.757664846476, 12206.084543659439, 12225.44985475638, 8207.671693132208, 8349.0, 8383.538905360263, 8402.453840500348, 8404.957975210085, 10350.223733219887, 11204.607838725606, 11221.214514983873, 11337.206395552232, 11431.771364572496], "value": 9364.506211997861, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1537.13152069081, 1578.7316156253435, 1773.7782777152856, 1862.7485289485933, 1877.0614692653674, 8373.16268373164, 9015.188633023026, 9408.15326620604, 9600.85598716019, 9659.80680386392, 8915.910840891589, 8962.551872406386, 8984.416012959153, 9074.591643376047, 9085.863712044325, 2452.798128916827, 2480.2063339731294, 2484.043643197373, 2486.527559763639, 2493.5511607910657, 2424.75752424757, 2434.257551446808, 2439.3413778279855, 2457.778799908008, 2461.126300163443, 2377.4888398994212, 2392.5334559760854, 2408.506256217471, 2411.360989337827, 2412.7707867752533, 2362.2204672458047, 2386.474975505386, 2389.450426401929, 2425.6967879015124, 2450.4486490539666, 2383.6662867198606, 2393.365758074094, 2398.304491697406, 2407.9398015049587, 2417.613181890889, 9284.164425201765, 9337.159655630958, 9391.577379017961, 9397.201237894787, 9492.335536512446, 5689.459501347406, 5808.767649294065, 5825.038868586678, 5826.446487583673, 5859.648421094748, 3484.372812893678, 3491.109767009422, 3705.7776533407814, 3728.571214310362, 3754.099016236111, 1120.9551617935272, 1137.8975892169744, 1149.4654985431814, 1162.4187906046977, 1178.599276246072, 13761.724765504734, 13781.655458613615, 13848.792268115987, 13919.930400348036, 13926.51257206003, 4891.119598472238, 5004.124278251292, 5013.874653133701, 5060.240963855451, 5087.974560127176, 11494.712632184095, 11550.653480395602, 11550.826737598944, 11558.248713833575, 11596.884031159749, 5745.85635359111, 5759.424057594291, 5771.797987070517, 5827.271591051119, 5839.240898683144, 4708.835190768306, 5123.97438012815, 5300.92048619271, 5307.310049693515, 5372.489613486712, 4318.265894797892, 4329.307310830252, 4345.869623911288, 4354.150940566559, 4421.38100665907, 1338.6854089289009, 1342.9189502450427, 1353.262471952788, 1357.932103394846, 1363.1275983370651, 916.5737931861717, 1059.105056227502, 1064.084886997182, 1067.0876400677464, 1071.1109778883663, 6377.0, 6474.773382931669, 6520.673966301666, 6564.934350656432, 6582.275949645536, 478.9976050119727, 479.29304276193034, 480.1573238965593, 499.47804544251346, 501.40583408660854, 4198.391233271159, 4239.173361194599, 4318.395424640553, 4332.285172946492, 4369.235383807884, 11801.232919860182, 12065.638030859089, 12129.33288669114, 12156.0, 12177.573784917486, 11682.773308802623, 11898.0, 12031.819522707166, 12034.879651203551, 12057.939710301567, 8514.403991720645, 8815.471071735588, 8826.426282291759, 8881.42270752399, 9075.682351117812, 6637.568558043905, 6657.500687448558, 6719.697613607497, 6764.053032575345, 6799.762008329685, 10577.471126443801, 10790.136789057013, 10868.0, 10966.067884229611, 10969.0, 11451.25566838153, 11495.712607184887, 11563.132765042486, 11637.709057273636, 11643.941780291383, 7617.733379331697, 8204.83590328178, 8299.6680132794, 8547.914520854712, 8630.870536942077, 9355.06449355059, 9363.344565880596, 9379.437233765995, 9388.906110938804, 9396.95301523488, 8332.875006874781, 8492.065872753868, 8543.91456085456, 8631.43895646781, 8677.956610216908, 8207.753767386988, 8249.381296402673, 8284.83430331402, 8316.459430137022, 8350.457220280663, 7255.0, 7482.503499300271, 7488.850222995618, 7539.849203016019, 7552.584607846621, 5378.139497680509, 5454.236406903116, 5516.779328826802, 5627.268455100811, 5736.913946290892, 5446.373667028342, 5552.611317207757, 5553.611247212818, 5659.094544872801, 5699.51554117888], "value": 4906.196707932598, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.9966600333996, 342.35700392966305, 344.51423492875045, 349.58748676561646, 351.7818952249606, 5484.451554844513, 5588.86027849303, 5607.7756889724415, 5646.350669672989, 5697.715114244292, 5575.526080283181, 5591.888162236763, 5602.215689803421, 5637.830865074044, 5644.322681278252, 4340.131973605284, 4351.586599273064, 4368.694191406603, 4388.956110438902, 4398.274284743014, 4138.834446622147, 4331.566843315674, 4359.912801743963, 4363.759993200372, 4383.605475507204, 4277.395976508809, 4278.0, 4298.517011630998, 4299.785010749466, 4321.481422229337, 4311.267084595611, 4329.935050974238, 4332.415123958257, 4351.673624478177, 4358.4987726411555, 3682.815859207029, 3766.642168993941, 3841.0973421245985, 3847.61523847613, 3850.191459793447, 5323.494268044529, 5337.893242135136, 5344.0, 5383.008286933859, 5387.946120538783, 4947.381577302837, 4948.628852836052, 4957.182064959277, 4962.751862406865, 4966.180580204262, 5550.250716153349, 5828.300603927556, 5837.824865254049, 5859.970700146472, 5895.64626122434, 4163.958360416387, 4189.72766770162, 4190.308599081148, 4193.329067349209, 4197.433346498215, 6108.786192483241, 6127.5404344674325, 6132.172156758825, 6133.202683651186, 6135.846603834895, 4140.896477588024, 4227.8097485613225, 4261.573842615714, 4262.3180291153885, 4268.87193384199, 4288.506821715543, 4304.763238021939, 4309.224339618899, 4336.371226172188, 4344.45694288214, 4883.240968852587, 4909.0, 4959.156943319645, 4987.750612469362, 4997.675151115166, 5795.652260864277, 5873.20711703923, 5914.704264786744, 5916.668749531321, 5922.378150294157, 1483.990886197396, 1487.4199062365685, 1492.2091291615461, 1498.7002599480147, 1498.707751988352, 915.8305713443034, 922.8925289652444, 942.7030485397078, 946.9573869175904, 947.5877993073035, 5011.373578302712, 5013.172826483662, 5046.369203849519, 5047.621428392885, 5078.619103567247, 5192.221166825007, 5260.947390526046, 5296.364436267596, 5320.467953204648, 5413.566914646819, 4839.104765618372, 4974.602031837444, 4987.850364489072, 5009.395114540492, 5083.7203953782155, 2847.0, 2875.9502781484607, 2877.5395936650034, 2883.659098519199, 2887.725666061721, 5461.563074953994, 5465.431247313756, 5492.105223697818, 5493.945060549423, 5550.888982220333, 5399.946000539944, 5653.632513886584, 6158.507319414436, 6163.8150855474405, 6208.192934918432, 6311.589746666452, 6315.210598675166, 6318.684065796691, 6340.714667839959, 6355.586886852339, 5962.373950735284, 6138.938610613836, 6139.723712432862, 6151.169592105009, 6159.876802464015, 5973.761049558143, 6009.338972712911, 6025.758969641341, 6060.2424696912885, 6106.542009349406, 5691.288588926384, 6311.2426508819235, 6315.147455093504, 6350.237971443456, 6352.968235158794, 4277.695302932635, 4283.914321713611, 4296.656267498655, 4304.5464085470985, 4310.267254566668, 6131.547381047617, 6136.478399335928, 6137.539684523768, 6142.3550527194, 6168.8766224674355, 5697.4302569742695, 5954.46409823118, 5984.803039392226, 5988.910166347596, 6001.5798894077, 5888.587798854211, 5954.821355359346, 5957.872117138364, 6014.518838492998, 6021.0, 5825.038868586806, 5838.32859221178, 5843.276233511209, 5856.238688970577, 5879.176915231957, 5662.57530685192, 5995.310539288038, 5995.850103747267, 6049.667268300285, 6071.180390647206, 5824.922389357982, 5885.293764748258, 5899.764009439575, 5905.43898329658, 5911.940880591311], "value": 4399.914691414128, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.533202744367, 823.1110400767171, 846.382141037043, 854.9059603443616, 875.6016012714216, 13199.604011879646, 13935.721285574307, 13972.301384930764, 14086.154830710151, 14118.22349770761, 12400.627981160556, 13810.516631917884, 13887.0, 13924.651883702913, 13935.860641393609, 819.512390127873, 839.3327304792705, 841.032812265893, 842.5702891525304, 843.2705709561216, 835.5613303015905, 835.6866175184306, 838.5974732128582, 838.9748307550752, 841.5035129273728, 873.4453621950075, 881.1628952495123, 883.0639522106587, 889.937704360695, 891.1133422244875, 874.7725591346232, 875.9693410730594, 878.2622597018535, 878.8242351529656, 882.4176043811086, 639.0637715746453, 639.6673729660597, 641.6470940982441, 641.6599202422677, 641.6759536434117, 14122.15267083968, 14179.936504762185, 14206.502772403019, 14445.205513696743, 14507.854921450757, 13723.45106195751, 13838.0, 14088.295585220698, 14522.201278929655, 14573.0, 11655.650330490098, 11765.764684706259, 11779.352135632536, 11811.645650630495, 11850.585229516926, 3943.132510847609, 3959.6238357356006, 4051.554329023805, 4131.9173616527505, 4138.6482149017365, 60240.0, 60318.095228571605, 60371.69814150901, 61139.69430152865, 61322.693386533225, 11063.446827658585, 11154.832677509843, 11184.720381990353, 11202.943985280184, 11247.100231981585, 19805.504862378268, 19812.90093549552, 19892.70160947587, 19929.900350498443, 19939.501512462306, 8540.145985401534, 8626.094260102724, 8645.221930026202, 8656.09111043344, 8692.217700406994, 4854.126257273654, 4915.508449155127, 4915.655904086751, 4952.306677065214, 4959.454460009396, 3468.8092154931214, 3577.982110089433, 3595.748297619194, 3599.9280014399565, 3608.675219230282, 635.2218532297898, 637.6684124255454, 656.9343065693488, 672.5695554844904, 672.8048865828953, 764.1746913333586, 769.5036701327613, 780.6174974262684, 817.8364327134597, 824.4888169335051, 10039.799204016024, 10177.592896284066, 10266.230032747573, 10442.2168337375, 10738.516766745515, 734.7501849371239, 759.1687102622619, 790.1782146567621, 800.5036877136213, 827.5903427803156, 4814.638902082358, 4839.879003024882, 4868.513148685103, 4870.147724148331, 4917.434495033045, 68052.0, 68695.62608747897, 69335.65332173307, 69756.30243697498, 70167.2983270171, 62430.37569624336, 62432.68783656143, 62775.0, 63740.36259637437, 64358.356416435236, 57397.26917750333, 57745.13382299269, 58212.0, 58675.41324586785, 59148.11277830836, 9002.0, 9076.636934522545, 9140.954295228481, 9149.268058555434, 9242.306826987868, 36722.26555468929, 36906.63093369032, 37219.441708374936, 37316.440253396766, 37580.0, 44148.55851441444, 48972.0, 49300.26049609187, 50527.74736126296, 50683.74658126686, 11969.940150299193, 12000.219985700902, 12064.638060858188, 12236.69408264765, 12337.321447320484, 12846.0, 13323.86676133265, 13350.332483375598, 13396.0, 13445.462181513021, 12588.811167832673, 12728.936355318165, 12779.297138657463, 13074.477020919057, 13171.868281317447, 12279.386030698608, 12507.874921250672, 12574.164775216155, 12626.494940202288, 12685.175463594836, 12203.0, 12575.0, 12599.307038112991, 12793.42429590652, 14184.645383865485, 11521.82717259225, 11740.70648233801, 12065.638030859089, 12205.389730513616, 12223.69440763988, 11907.404629768303, 11944.76110477803, 12116.0, 12117.454714538044, 12210.57262995791], "value": 7103.552235274614, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.9000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 114.0, 104.0, 109.0, 111.0, 111.0, 105.0, 108.0, 109.0, 111.0], "value": 109.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 126.0, 152.0, 218.0, 125.0, 160.0, 154.0, 127.0, 175.0, 124.0], "value": 151.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 162.0, 162.0, 164.0, 178.0, 163.0, 163.0, 162.0, 161.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 168.0, 76.0, 75.0, 74.0, 75.0, 165.0, 76.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 90.0, 170.0, 91.0, 91.0, 91.0, 149.0, 93.0, 91.0, 146.0], "value": 110.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 122.0, 120.0, 121.0, 121.0, 121.0, 121.0], "value": 119.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 146.0, 148.0, 148.0, 146.0, 148.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 54.0, 57.0, 57.0, 55.0, 111.0, 55.0, 56.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 58.0, 59.0, 60.0, 59.0, 58.0, 58.0, 58.0, 58.0], "value": 58.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 83.0, 80.0, 83.0, 79.0, 83.0, 82.0, 82.0, 83.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 128.0, 132.0, 129.0, 122.0, 121.0, 120.0, 141.0, 197.0, 123.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 162.0, 166.0, 163.0, 167.0, 156.0, 166.0, 157.0, 163.0, 164.0], "value": 163.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 64.0, 63.0, 63.0, 63.0, 63.0, 61.0, 63.0], "value": 63.8, "unit": "score"}]}]} 15:14:06 INFO - Return code: 0 15:14:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 15:14:07 ERROR - # TBPL SUCCESS # 15:14:07 INFO - Running post-action listener: _resource_record_post_action 15:14:07 INFO - ##### 15:14:07 INFO - ##### Finished run-tests step (success) 15:14:07 INFO - ##### 15:14:07 INFO - Running post-run listener: _resource_record_post_run 15:14:07 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 135168; Write bytes: 305266688; Read time: 44; Write time: 242716 15:14:07 INFO - TinderboxPrint: CPU usage
13.4% 15:14:07 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 44 15:14:07 INFO - TinderboxPrint: I/O write bytes / time
305,266,688 / 242,716 15:14:07 INFO - TinderboxPrint: CPU idle
8,222.8 (86.6%) 15:14:07 INFO - TinderboxPrint: CPU user
1,216.1 (12.8%) 15:14:07 INFO - TinderboxPrint: Swap in / out
0 / 0 15:14:07 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 20094976; Read time: 0; Write time: 9308 15:14:07 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 135168; Write bytes: 285171712; Read time: 44; Write time: 233408 15:14:07 INFO - Running post-run listener: _upload_blobber_files 15:14:07 INFO - Blob upload gear active. 15:14:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:14:07 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:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:14:08 INFO - (blobuploader) - INFO - Open directory for files ... 15:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:14:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:08 INFO - (blobuploader) - INFO - Done attempting. 15:14:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:14:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:14:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:09 INFO - (blobuploader) - INFO - Done attempting. 15:14:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:14:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:14:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:14:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:14:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:14:14 INFO - (blobuploader) - INFO - Done attempting. 15:14:14 INFO - (blobuploader) - INFO - Iteration through files over. 15:14:14 INFO - Return code: 0 15:14:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:14:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:14:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932cd2e7c7cd76d6105a8879c83368012229863f03a01035078a313688981651c8d0ca5fdf2633db36dcf7126f5c7b4b37a84cc4fa975841de65b09a705024db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/946944c0d0731af89f92a9e97edd897023f945266454a26526b7fcba84e8da2fc379c92e745b1c0c7024eaeded4bc583155e6a8204d2011b59b1d53b10b3542f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b167bd6612092e8da37af89975f80b9fff293555004f8cc9230c7797f6aa62ad297bded89c14438e39cad55ad6a47218f52b8386424a9a5a9f4bcdeec6a50f8c"} 15:14:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:14:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:14:14 INFO - Contents: 15:14:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932cd2e7c7cd76d6105a8879c83368012229863f03a01035078a313688981651c8d0ca5fdf2633db36dcf7126f5c7b4b37a84cc4fa975841de65b09a705024db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/946944c0d0731af89f92a9e97edd897023f945266454a26526b7fcba84e8da2fc379c92e745b1c0c7024eaeded4bc583155e6a8204d2011b59b1d53b10b3542f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b167bd6612092e8da37af89975f80b9fff293555004f8cc9230c7797f6aa62ad297bded89c14438e39cad55ad6a47218f52b8386424a9a5a9f4bcdeec6a50f8c"} 15:14:14 INFO - Running post-run listener: copy_logs_to_upload_dir 15:14:14 INFO - Copying logs to upload dir... 15:14:14 INFO - mkdir: /builds/slave/test/build/upload/logs 15:14:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.602582 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2016-05-13 15:14:14.114714) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:14.119135) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932cd2e7c7cd76d6105a8879c83368012229863f03a01035078a313688981651c8d0ca5fdf2633db36dcf7126f5c7b4b37a84cc4fa975841de65b09a705024db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/946944c0d0731af89f92a9e97edd897023f945266454a26526b7fcba84e8da2fc379c92e745b1c0c7024eaeded4bc583155e6a8204d2011b59b1d53b10b3542f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b167bd6612092e8da37af89975f80b9fff293555004f8cc9230c7797f6aa62ad297bded89c14438e39cad55ad6a47218f52b8386424a9a5a9f4bcdeec6a50f8c"} build_url:http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011091 build_url: 'http://archive.mozilla.org/pub/firefox/tinderbox-builds/fx-team-linux64-pgo/1463164213/firefox-49.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/932cd2e7c7cd76d6105a8879c83368012229863f03a01035078a313688981651c8d0ca5fdf2633db36dcf7126f5c7b4b37a84cc4fa975841de65b09a705024db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/946944c0d0731af89f92a9e97edd897023f945266454a26526b7fcba84e8da2fc379c92e745b1c0c7024eaeded4bc583155e6a8204d2011b59b1d53b10b3542f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b167bd6612092e8da37af89975f80b9fff293555004f8cc9230c7797f6aa62ad297bded89c14438e39cad55ad6a47218f52b8386424a9a5a9f4bcdeec6a50f8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:14.146132) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:14.146452) ========= 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=74d6aec007b0fa31a864ebd7000001f8-1463176404.51044-795963475 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004440 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-13 15:14:14.232760) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:14:14.233162) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-13 15:14:14.233532) ========= ========= Total master_lag: 0.18 =========